builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-032 starttime: 1495947566.92 results: success (0) revision: ee96ce3c71b79064efe8ab2c7ff35e6b6220a475 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-27 21:59:26.917127) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-27 21:59:26.917723) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-27 21:59:26.918008) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-27 21:59:26.946772) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-27 21:59:26.947074) ========= 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=745a4373a2a16df560f216e000000264-1495944412.112491-529162384 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-05-27 21:59:27-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 38.9M=0s 2017-05-27 21:59:27 (38.9 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.132238 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-27 21:59:27.091818) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-27 21:59:27.092097) ========= 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=745a4373a2a16df560f216e000000264-1495944412.112491-529162384 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015626 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-27 21:59:27.140979) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-27 21:59:27.141406) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev ee96ce3c71b79064efe8ab2c7ff35e6b6220a475 --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 ee96ce3c71b79064efe8ab2c7ff35e6b6220a475 --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=745a4373a2a16df560f216e000000264-1495944412.112491-529162384 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-05-27 21:59:27,293 truncating revision to first 12 chars 2017-05-27 21:59:27,294 Setting DEBUG logging. 2017-05-27 21:59:27,294 attempt 1/10 2017-05-27 21:59:27,294 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/ee96ce3c71b7?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-27 21:59:27,645 unpacking tar archive at: mozilla-central-ee96ce3c71b7/testing/mozharness/ program finished with exit code 0 elapsedTime=0.736117 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-27 21:59:27.890914) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-27 21:59:27.891233) ========= script_repo_revision: ee96ce3c71b79064efe8ab2c7ff35e6b6220a475 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-27 21:59:27.891664) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-27 21:59:27.891941) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-27 21:59:27.900871) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 0 secs) (at 2017-05-27 21:59:27.901144) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 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-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] 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=745a4373a2a16df560f216e000000264-1495944412.112491-529162384 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 21:59:28 INFO - MultiFileLogger online at 20170527 21:59:28 in /builds/slave/test 21:59:28 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 21:59:28 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 21:59:28 INFO - {'append_to_log': False, 21:59:28 INFO - 'base_work_dir': '/builds/slave/test', 21:59:28 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 21:59:28 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 21:59:28 INFO - 'branch': 'Firefox-Non-PGO', 21:59:28 INFO - 'buildbot_json_path': 'buildprops.json', 21:59:28 INFO - 'config_files': ('talos/linux_config.py',), 21:59:28 INFO - 'default_actions': ('clobber', 21:59:28 INFO - 'read-buildbot-config', 21:59:28 INFO - 'download-and-extract', 21:59:28 INFO - 'populate-webroot', 21:59:28 INFO - 'create-virtualenv', 21:59:28 INFO - 'install', 21:59:28 INFO - 'setup-mitmproxy', 21:59:28 INFO - 'run-tests'), 21:59:28 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 21:59:28 INFO - 'download_minidump_stackwalk': True, 21:59:28 INFO - 'download_symbols': 'ondemand', 21:59:28 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 21:59:28 INFO - 'tooltool.py': '/tools/tooltool.py', 21:59:28 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 21:59:28 INFO - '/tools/misc-python/virtualenv.py')}, 21:59:28 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 21:59:28 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 21:59:28 INFO - 'gecko_profile': False, 21:59:28 INFO - 'gecko_profile_interval': 0, 21:59:28 INFO - 'installer_path': 'installer.exe', 21:59:28 INFO - 'log_level': 'info', 21:59:28 INFO - 'log_name': 'talos', 21:59:28 INFO - 'log_to_console': True, 21:59:28 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 21:59:28 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 21:59:28 INFO - 'opt_config_files': (), 21:59:28 INFO - 'pip_index': False, 21:59:28 INFO - 'suite': 'dromaeojs-e10s', 21:59:28 INFO - 'system_bits': '32', 21:59:28 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 21:59:28 INFO - 'title': 'talos-linux64-ix-032', 21:59:28 INFO - 'tooltool_cache': '/builds/tooltool_cache', 21:59:28 INFO - 'use_talos_json': True, 21:59:28 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 21:59:28 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 21:59:28 INFO - 'work_dir': 'build'} 21:59:28 INFO - [mozharness: 2017-05-28 04:59:28.152230Z] Running clobber step. 21:59:28 INFO - Running pre-action listener: _resource_record_pre_action 21:59:28 INFO - Running main action method: clobber 21:59:28 INFO - rmtree: /builds/slave/test/build 21:59:28 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 21:59:29 INFO - Running post-action listener: _resource_record_post_action 21:59:29 INFO - [mozharness: 2017-05-28 04:59:29.165266Z] Finished clobber step (success) 21:59:29 INFO - [mozharness: 2017-05-28 04:59:29.165368Z] Running read-buildbot-config step. 21:59:29 INFO - Running pre-action listener: _resource_record_pre_action 21:59:29 INFO - Running main action method: read_buildbot_config 21:59:29 INFO - Using buildbot properties: 21:59:29 INFO - { 21:59:29 INFO - "project": "", 21:59:29 INFO - "product": "firefox", 21:59:29 INFO - "who": "philringnalda@gmail.com", 21:59:29 INFO - "installer_path": "public/build/target.tar.bz2", 21:59:29 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 21:59:29 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 21:59:29 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 21:59:29 INFO - "stage_platform": "linux64", 21:59:29 INFO - "basedir": "/builds/slave/test", 21:59:29 INFO - "buildnumber": 910, 21:59:29 INFO - "platform": "ubuntu64_hw", 21:59:29 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 21:59:29 INFO - "slavebuilddir": "test", 21:59:29 INFO - "taskId": "XSokkdfxQ_ePkyBBQEqpyA", 21:59:29 INFO - "branch": "mozilla-central", 21:59:29 INFO - "script_repo_revision": "production", 21:59:29 INFO - "revision": "ee96ce3c71b79064efe8ab2c7ff35e6b6220a475", 21:59:29 INFO - "slavename": "talos-linux64-ix-032", 21:59:29 INFO - "repo_path": "mozilla-central" 21:59:29 INFO - } 21:59:29 INFO - Finding installer, test and symbols from parent task. 21:59:29 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/XSokkdfxQ_ePkyBBQEqpyA'}, attempt #1 21:59:29 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/XSokkdfxQ_ePkyBBQEqpyA'}, attempt #1 21:59:30 INFO - Task dependencies: R8Wmzd1jQ_-NCuyrMuTTjA 21:59:30 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/R8Wmzd1jQ_-NCuyrMuTTjA'}, attempt #1 21:59:30 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/R8Wmzd1jQ_-NCuyrMuTTjA/artifacts/public/build/target.tar.bz2 21:59:30 INFO - Set test_url: https://queue.taskcluster.net/v1/task/R8Wmzd1jQ_-NCuyrMuTTjA/artifacts/public/build/test_packages.json 21:59:30 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/R8Wmzd1jQ_-NCuyrMuTTjA/artifacts/public/build/target.crashreporter-symbols.zip 21:59:30 INFO - Running post-action listener: _resource_record_post_action 21:59:30 INFO - [mozharness: 2017-05-28 04:59:30.485995Z] Finished read-buildbot-config step (success) 21:59:30 INFO - [mozharness: 2017-05-28 04:59:30.486216Z] Running download-and-extract step. 21:59:30 INFO - Running pre-action listener: _resource_record_pre_action 21:59:30 INFO - Running main action method: download_and_extract 21:59:30 INFO - mkdir: /builds/slave/test/build/tests 21:59:30 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')]} 21:59:30 INFO - trying https://queue.taskcluster.net/v1/task/R8Wmzd1jQ_-NCuyrMuTTjA/artifacts/public/build/target.test_packages.json 21:59:30 INFO - Downloading https://queue.taskcluster.net/v1/task/R8Wmzd1jQ_-NCuyrMuTTjA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 21:59:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/R8Wmzd1jQ_-NCuyrMuTTjA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 21:59:31 INFO - Downloaded 986 bytes. 21:59:31 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 21:59:31 INFO - Using the following test package requirements: 21:59:31 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 21:59:31 INFO - u'common': [u'target.common.tests.zip'], 21:59:31 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 21:59:31 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 21:59:31 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 21:59:31 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 21:59:31 INFO - u'mozbase': [u'target.common.tests.zip'], 21:59:31 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 21:59:31 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 21:59:31 INFO - u'web-platform': [u'target.common.tests.zip', 21:59:31 INFO - u'target.web-platform.tests.zip'], 21:59:31 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 21:59:31 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 21:59:31 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/R8Wmzd1jQ_-NCuyrMuTTjA/artifacts/public/build/target.common.tests.zip 21:59:31 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/R8Wmzd1jQ_-NCuyrMuTTjA/artifacts/public/build/target.common.tests.zip'}, attempt #1 21:59:31 INFO - Fetch https://queue.taskcluster.net/v1/task/R8Wmzd1jQ_-NCuyrMuTTjA/artifacts/public/build/target.common.tests.zip into memory 21:59:33 INFO - Content-Length response header: 63526723 21:59:33 INFO - Bytes received: 63526723 21:59:44 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 21:59:44 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/R8Wmzd1jQ_-NCuyrMuTTjA/artifacts/public/build/target.common.tests.zip 21:59:44 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/R8Wmzd1jQ_-NCuyrMuTTjA/artifacts/public/build/target.common.tests.zip'}, attempt #1 21:59:44 INFO - Fetch https://queue.taskcluster.net/v1/task/R8Wmzd1jQ_-NCuyrMuTTjA/artifacts/public/build/target.common.tests.zip into memory 21:59:45 INFO - Content-Length response header: 63526723 21:59:45 INFO - Bytes received: 63526723 21:59:59 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/R8Wmzd1jQ_-NCuyrMuTTjA/artifacts/public/build/target.talos.tests.zip 21:59:59 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/R8Wmzd1jQ_-NCuyrMuTTjA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 21:59:59 INFO - Fetch https://queue.taskcluster.net/v1/task/R8Wmzd1jQ_-NCuyrMuTTjA/artifacts/public/build/target.talos.tests.zip into memory 22:00:00 INFO - Content-Length response header: 14447425 22:00:00 INFO - Bytes received: 14447425 22:00:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:00:00 INFO - trying https://queue.taskcluster.net/v1/task/R8Wmzd1jQ_-NCuyrMuTTjA/artifacts/public/build/target.tar.bz2 22:00:00 INFO - Downloading https://queue.taskcluster.net/v1/task/R8Wmzd1jQ_-NCuyrMuTTjA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 22:00:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/R8Wmzd1jQ_-NCuyrMuTTjA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 22:00:01 INFO - Downloaded 54221968 bytes. 22:00:01 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/R8Wmzd1jQ_-NCuyrMuTTjA/artifacts/public/build/target.tar.bz2 22:00:01 INFO - mkdir: /builds/slave/test/properties 22:00:01 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 22:00:01 INFO - Writing to file /builds/slave/test/properties/build_url 22:00:01 INFO - Contents: 22:00:01 INFO - build_url:https://queue.taskcluster.net/v1/task/R8Wmzd1jQ_-NCuyrMuTTjA/artifacts/public/build/target.tar.bz2 22:00:01 INFO - Running post-action listener: _resource_record_post_action 22:00:01 INFO - Running post-action listener: set_extra_try_arguments 22:00:01 INFO - [mozharness: 2017-05-28 05:00:01.566007Z] Finished download-and-extract step (success) 22:00:01 INFO - [mozharness: 2017-05-28 05:00:01.566104Z] Running populate-webroot step. 22:00:01 INFO - Running pre-action listener: _resource_record_pre_action 22:00:01 INFO - Running main action method: populate_webroot 22:00:01 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 22:00:01 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 22:00:01 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 22:00:01 INFO - '--tppagecycles', 22:00:01 INFO - '7'], 22:00:01 INFO - 'tests': ['tsvgm']}}, 22:00:01 INFO - 'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 22:00:01 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 22:00:01 INFO - 'tests': ['dromaeo_css', 'kraken']}, 22:00:01 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 22:00:01 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 22:00:01 INFO - 'talos_options': ['--disable-e10s'], 22:00:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:00:01 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 22:00:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:00:01 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 22:00:01 INFO - 'talos_options': ['--disable-e10s'], 22:00:01 INFO - 'tests': ['damp', 'tps']}, 22:00:01 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 22:00:01 INFO - 'tests': ['damp', 'tps']}, 22:00:01 INFO - 'g3': {'talos_options': ['--disable-e10s'], 22:00:01 INFO - 'tests': ['dromaeo_dom']}, 22:00:01 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 22:00:01 INFO - 'g4': {'talos_options': ['--disable-e10s'], 22:00:01 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 22:00:01 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 22:00:01 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 22:00:01 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 22:00:01 INFO - 'other': {'talos_options': ['--disable-e10s'], 22:00:01 INFO - 'tests': ['a11yr', 22:00:01 INFO - 'ts_paint', 22:00:01 INFO - 'tpaint', 22:00:01 INFO - 'sessionrestore', 22:00:01 INFO - 'sessionrestore_no_auto_restore', 22:00:01 INFO - 'tabpaint']}, 22:00:01 INFO - 'other-e10s': {'tests': ['a11yr', 22:00:01 INFO - 'ts_paint', 22:00:01 INFO - 'tpaint', 22:00:01 INFO - 'sessionrestore', 22:00:01 INFO - 'sessionrestore_no_auto_restore', 22:00:01 INFO - 'tabpaint']}, 22:00:01 INFO - 'other-e10s_l64': {'tests': ['a11yr', 22:00:01 INFO - 'ts_paint', 22:00:01 INFO - 'tpaint', 22:00:01 INFO - 'sessionrestore', 22:00:01 INFO - 'sessionrestore_no_auto_restore', 22:00:01 INFO - 'tabpaint']}, 22:00:01 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 22:00:01 INFO - 'ts_paint', 22:00:01 INFO - 'tpaint', 22:00:01 INFO - 'sessionrestore', 22:00:01 INFO - 'sessionrestore_no_auto_restore', 22:00:01 INFO - 'tabpaint']}, 22:00:01 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 22:00:01 INFO - 'tests': ['a11yr', 22:00:01 INFO - 'ts_paint', 22:00:01 INFO - 'tpaint', 22:00:01 INFO - 'sessionrestore', 22:00:01 INFO - 'sessionrestore_no_auto_restore', 22:00:01 INFO - 'tabpaint']}, 22:00:01 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 22:00:01 INFO - 'tests': ['a11yr', 22:00:01 INFO - 'ts_paint', 22:00:01 INFO - 'tpaint', 22:00:01 INFO - 'sessionrestore', 22:00:01 INFO - 'sessionrestore_no_auto_restore', 22:00:01 INFO - 'tabpaint']}, 22:00:01 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 22:00:01 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 22:00:01 INFO - 'bloom_basic_ref']}, 22:00:01 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set.zip', 22:00:01 INFO - 'talos_options': ['--mitmproxy', 22:00:01 INFO - 'mitmproxy-recording-1.mp', 22:00:01 INFO - '--firstNonBlankPaint'], 22:00:01 INFO - 'tests': ['Quantum_1']}, 22:00:01 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 22:00:01 INFO - 'tests': ['tsvgx', 22:00:01 INFO - 'tsvgr_opacity', 22:00:01 INFO - 'tart', 22:00:01 INFO - 'tscrollx', 22:00:01 INFO - 'cart', 22:00:01 INFO - 'tsvg_static']}, 22:00:01 INFO - 'svgr-e10s': {'tests': ['tsvgx', 22:00:01 INFO - 'tsvgr_opacity', 22:00:01 INFO - 'tart', 22:00:01 INFO - 'tscrollx', 22:00:01 INFO - 'cart', 22:00:01 INFO - 'tsvg_static']}, 22:00:01 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 22:00:01 INFO - 'talos_options': ['--disable-e10s'], 22:00:01 INFO - 'tests': ['tp5o']}, 22:00:01 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 22:00:01 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 22:00:01 INFO - 'talos_options': ['--disable-e10s', 22:00:01 INFO - '--xperf_path', 22:00:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:00:01 INFO - 'tests': ['tp5n']}, 22:00:01 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 22:00:01 INFO - 'talos_options': ['--xperf_path', 22:00:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:00:01 INFO - 'tests': ['tp5n']}}, 22:00:01 INFO - 'talos.zip': {'path': '', 22:00:01 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 22:00:01 INFO - Running post-action listener: _resource_record_post_action 22:00:01 INFO - [mozharness: 2017-05-28 05:00:01.580387Z] Finished populate-webroot step (success) 22:00:01 INFO - [mozharness: 2017-05-28 05:00:01.580502Z] Running create-virtualenv step. 22:00:01 INFO - Running pre-action listener: _resource_record_pre_action 22:00:01 INFO - Running main action method: create_virtualenv 22:00:01 INFO - Creating virtualenv /builds/slave/test/build/venv 22:00:01 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 22:00:01 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 22:00:01 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 22:00:01 INFO - Using real prefix '/usr' 22:00:01 INFO - New python executable in /builds/slave/test/build/venv/bin/python 22:00:02 INFO - Installing distribute.............................................................................................................................................................................................done. 22:00:04 INFO - Installing pip.................done. 22:00:04 INFO - Return code: 0 22:00:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 22:00:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 22:00:04 INFO - Reading from file tmpfile_stdout 22:00:04 INFO - Output received: 22:00:04 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) 22:00:04 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 22:00:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:00:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:00:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:00:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:00:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x234d3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2527a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26caef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26c7e40>, '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 0x26c8fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26c9440>, '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': '745a4373a2a16df560f216e000000264-1495944412.112491-529162384', '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 22:00:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 22:00:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 22:00:04 INFO - Using env: {'DISPLAY': ':0', 22:00:04 INFO - 'HOME': '/home/cltbld', 22:00:04 INFO - 'LANG': 'en_US.UTF-8', 22:00:04 INFO - 'LANGUAGE': 'en_US:en', 22:00:04 INFO - 'LOGNAME': 'cltbld', 22:00:04 INFO - 'MAIL': '/var/mail/cltbld', 22:00:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:00:04 INFO - 'MOZ_NO_REMOTE': '1', 22:00:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:00:04 INFO - 'NO_EM_RESTART': '1', 22:00:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:00:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:00:04 INFO - 'PWD': '/builds/slave/test', 22:00:04 INFO - 'SHELL': '/bin/bash', 22:00:04 INFO - 'SHLVL': '1', 22:00:04 INFO - 'TERM': 'linux', 22:00:04 INFO - 'TMOUT': '86400', 22:00:04 INFO - 'USER': 'cltbld', 22:00:04 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1495944412.112491-529162384', 22:00:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:00:04 INFO - '_': '/tools/buildbot/bin/python'} 22:00:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:00:04 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 22:00:04 INFO - Cleaning up... 22:00:04 INFO - Return code: 0 22:00:04 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 22:00:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:00:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:00:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:00:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:00:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x234d3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2527a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26caef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26c7e40>, '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 0x26c8fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26c9440>, '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': '745a4373a2a16df560f216e000000264-1495944412.112491-529162384', '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 22:00:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 22:00:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 22:00:04 INFO - Using env: {'DISPLAY': ':0', 22:00:04 INFO - 'HOME': '/home/cltbld', 22:00:04 INFO - 'LANG': 'en_US.UTF-8', 22:00:04 INFO - 'LANGUAGE': 'en_US:en', 22:00:04 INFO - 'LOGNAME': 'cltbld', 22:00:04 INFO - 'MAIL': '/var/mail/cltbld', 22:00:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:00:04 INFO - 'MOZ_NO_REMOTE': '1', 22:00:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:00:04 INFO - 'NO_EM_RESTART': '1', 22:00:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:00:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:00:04 INFO - 'PWD': '/builds/slave/test', 22:00:04 INFO - 'SHELL': '/bin/bash', 22:00:04 INFO - 'SHLVL': '1', 22:00:04 INFO - 'TERM': 'linux', 22:00:04 INFO - 'TMOUT': '86400', 22:00:04 INFO - 'USER': 'cltbld', 22:00:04 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1495944412.112491-529162384', 22:00:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:00:04 INFO - '_': '/tools/buildbot/bin/python'} 22:00:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:00:04 INFO - Downloading/unpacking psutil>=3.1.1 22:00:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:00:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:00:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:00:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:00:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 22:00:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:00:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:00:05 INFO - Installing collected packages: psutil 22:00:06 INFO - Running setup.py install for psutil 22:00:06 INFO - building 'psutil._psutil_linux' extension 22:00:06 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 22:00:06 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 22:00:06 INFO - building 'psutil._psutil_posix' extension 22:00:06 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 22:00:06 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 22:00:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:00:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:00:06 INFO - Successfully installed psutil 22:00:06 INFO - Cleaning up... 22:00:06 INFO - Return code: 0 22:00:06 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 22:00:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:00:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:00:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:00:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:00:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x234d3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2527a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26caef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26c7e40>, '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 0x26c8fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26c9440>, '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': '745a4373a2a16df560f216e000000264-1495944412.112491-529162384', '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 22:00:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 22:00:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 22:00:06 INFO - Using env: {'DISPLAY': ':0', 22:00:06 INFO - 'HOME': '/home/cltbld', 22:00:06 INFO - 'LANG': 'en_US.UTF-8', 22:00:06 INFO - 'LANGUAGE': 'en_US:en', 22:00:06 INFO - 'LOGNAME': 'cltbld', 22:00:06 INFO - 'MAIL': '/var/mail/cltbld', 22:00:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:00:06 INFO - 'MOZ_NO_REMOTE': '1', 22:00:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:00:06 INFO - 'NO_EM_RESTART': '1', 22:00:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:00:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:00:06 INFO - 'PWD': '/builds/slave/test', 22:00:06 INFO - 'SHELL': '/bin/bash', 22:00:06 INFO - 'SHLVL': '1', 22:00:06 INFO - 'TERM': 'linux', 22:00:06 INFO - 'TMOUT': '86400', 22:00:06 INFO - 'USER': 'cltbld', 22:00:06 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1495944412.112491-529162384', 22:00:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:00:06 INFO - '_': '/tools/buildbot/bin/python'} 22:00:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:00:06 INFO - Downloading/unpacking mozsystemmonitor==0.3 22:00:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:00:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:00:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:00:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:00:07 INFO - Downloading mozsystemmonitor-0.3.tar.gz 22:00:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 22:00:07 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 22:00:07 INFO - Installing collected packages: mozsystemmonitor 22:00:07 INFO - Running setup.py install for mozsystemmonitor 22:00:07 INFO - Successfully installed mozsystemmonitor 22:00:07 INFO - Cleaning up... 22:00:08 INFO - Return code: 0 22:00:08 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 22:00:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:00:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:00:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:00:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:00:08 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 0x234d3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2527a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26caef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26c7e40>, '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 0x26c8fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26c9440>, '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': '745a4373a2a16df560f216e000000264-1495944412.112491-529162384', '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 22:00:08 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 22:00:08 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 22:00:08 INFO - Using env: {'DISPLAY': ':0', 22:00:08 INFO - 'HOME': '/home/cltbld', 22:00:08 INFO - 'LANG': 'en_US.UTF-8', 22:00:08 INFO - 'LANGUAGE': 'en_US:en', 22:00:08 INFO - 'LOGNAME': 'cltbld', 22:00:08 INFO - 'MAIL': '/var/mail/cltbld', 22:00:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:00:08 INFO - 'MOZ_NO_REMOTE': '1', 22:00:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:00:08 INFO - 'NO_EM_RESTART': '1', 22:00:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:00:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:00:08 INFO - 'PWD': '/builds/slave/test', 22:00:08 INFO - 'SHELL': '/bin/bash', 22:00:08 INFO - 'SHLVL': '1', 22:00:08 INFO - 'TERM': 'linux', 22:00:08 INFO - 'TMOUT': '86400', 22:00:08 INFO - 'USER': 'cltbld', 22:00:08 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1495944412.112491-529162384', 22:00:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:00:08 INFO - '_': '/tools/buildbot/bin/python'} 22:00:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:00:08 INFO - Downloading/unpacking jsonschema==2.5.1 22:00:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:00:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:00:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:00:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:00:09 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 22:00:09 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 22:00:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:00:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:00:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:00:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:00:09 INFO - Downloading functools32-3.2.3-2.tar.gz 22:00:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 22:00:09 INFO - warning: no files found matching '*.txt' 22:00:09 INFO - no previously-included directories found matching 'build' 22:00:09 INFO - no previously-included directories found matching 'dist' 22:00:09 INFO - no previously-included directories found matching '.git*' 22:00:09 INFO - Installing collected packages: jsonschema, functools32 22:00:09 INFO - Running setup.py install for functools32 22:00:09 INFO - warning: no files found matching '*.txt' 22:00:09 INFO - no previously-included directories found matching 'build' 22:00:09 INFO - no previously-included directories found matching 'dist' 22:00:09 INFO - no previously-included directories found matching '.git*' 22:00:09 INFO - Successfully installed jsonschema functools32 22:00:09 INFO - Cleaning up... 22:00:09 INFO - Return code: 0 22:00:09 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 22:00:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:00:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:00:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:00:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:00:09 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 0x234d3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2527a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26caef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26c7e40>, '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 0x26c8fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26c9440>, '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': '745a4373a2a16df560f216e000000264-1495944412.112491-529162384', '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 22:00:09 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 22:00:09 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 22:00:09 INFO - Using env: {'DISPLAY': ':0', 22:00:09 INFO - 'HOME': '/home/cltbld', 22:00:09 INFO - 'LANG': 'en_US.UTF-8', 22:00:09 INFO - 'LANGUAGE': 'en_US:en', 22:00:09 INFO - 'LOGNAME': 'cltbld', 22:00:09 INFO - 'MAIL': '/var/mail/cltbld', 22:00:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:00:09 INFO - 'MOZ_NO_REMOTE': '1', 22:00:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:00:09 INFO - 'NO_EM_RESTART': '1', 22:00:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:00:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:00:09 INFO - 'PWD': '/builds/slave/test', 22:00:09 INFO - 'SHELL': '/bin/bash', 22:00:09 INFO - 'SHLVL': '1', 22:00:09 INFO - 'TERM': 'linux', 22:00:09 INFO - 'TMOUT': '86400', 22:00:09 INFO - 'USER': 'cltbld', 22:00:09 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1495944412.112491-529162384', 22:00:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:00:09 INFO - '_': '/tools/buildbot/bin/python'} 22:00:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:00:10 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 22:00:10 INFO - Cleaning up... 22:00:10 INFO - Return code: 0 22:00:10 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 22:00:10 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')]} 22:00:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:00:10 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')]} 22:00:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:00:10 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 0x234d3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2527a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26caef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26c7e40>, '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 0x26c8fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26c9440>, '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': '745a4373a2a16df560f216e000000264-1495944412.112491-529162384', '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 22:00:10 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 22:00:10 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 22:00:10 INFO - Using env: {'DISPLAY': ':0', 22:00:10 INFO - 'HOME': '/home/cltbld', 22:00:10 INFO - 'LANG': 'en_US.UTF-8', 22:00:10 INFO - 'LANGUAGE': 'en_US:en', 22:00:10 INFO - 'LOGNAME': 'cltbld', 22:00:10 INFO - 'MAIL': '/var/mail/cltbld', 22:00:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:00:10 INFO - 'MOZ_NO_REMOTE': '1', 22:00:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:00:10 INFO - 'NO_EM_RESTART': '1', 22:00:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:00:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:00:10 INFO - 'PWD': '/builds/slave/test', 22:00:10 INFO - 'SHELL': '/bin/bash', 22:00:10 INFO - 'SHLVL': '1', 22:00:10 INFO - 'TERM': 'linux', 22:00:10 INFO - 'TMOUT': '86400', 22:00:10 INFO - 'USER': 'cltbld', 22:00:10 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1495944412.112491-529162384', 22:00:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:00:10 INFO - '_': '/tools/buildbot/bin/python'} 22:00:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:00:10 INFO - Downloading/unpacking blobuploader==1.2.4 22:00:10 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 22:00:10 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 22:00:10 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 22:00:10 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 22:00:11 INFO - Downloading blobuploader-1.2.4.tar.gz 22:00:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 22:00:11 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 22:00:11 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 22:00:11 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 22:00:11 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 22:00:11 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 22:00:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 22:00:11 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 22:00:11 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 22:00:11 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 22:00:11 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 22:00:11 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 22:00:11 INFO - Downloading docopt-0.6.1.tar.gz 22:00:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 22:00:11 INFO - Installing collected packages: blobuploader, requests, docopt 22:00:11 INFO - Running setup.py install for blobuploader 22:00:12 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 22:00:12 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 22:00:12 INFO - Running setup.py install for requests 22:00:12 INFO - Running setup.py install for docopt 22:00:12 INFO - Successfully installed blobuploader requests docopt 22:00:12 INFO - Cleaning up... 22:00:12 INFO - Return code: 0 22:00:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:00:12 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')]} 22:00:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:00:12 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')]} 22:00:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:00:12 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 0x234d3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2527a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26caef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26c7e40>, '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 0x26c8fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26c9440>, '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': '745a4373a2a16df560f216e000000264-1495944412.112491-529162384', '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 22:00:12 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 22:00:12 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 22:00:12 INFO - Using env: {'DISPLAY': ':0', 22:00:12 INFO - 'HOME': '/home/cltbld', 22:00:12 INFO - 'LANG': 'en_US.UTF-8', 22:00:12 INFO - 'LANGUAGE': 'en_US:en', 22:00:12 INFO - 'LOGNAME': 'cltbld', 22:00:12 INFO - 'MAIL': '/var/mail/cltbld', 22:00:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:00:12 INFO - 'MOZ_NO_REMOTE': '1', 22:00:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:00:12 INFO - 'NO_EM_RESTART': '1', 22:00:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:00:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:00:12 INFO - 'PWD': '/builds/slave/test', 22:00:12 INFO - 'SHELL': '/bin/bash', 22:00:12 INFO - 'SHLVL': '1', 22:00:12 INFO - 'TERM': 'linux', 22:00:12 INFO - 'TMOUT': '86400', 22:00:12 INFO - 'USER': 'cltbld', 22:00:12 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1495944412.112491-529162384', 22:00:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:00:12 INFO - '_': '/tools/buildbot/bin/python'} 22:00:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:00:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:00:12 INFO - Running setup.py (path:/tmp/pip-4nSojO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:00:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:00:12 INFO - Running setup.py (path:/tmp/pip-YltbNy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:00:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:00:12 INFO - Running setup.py (path:/tmp/pip-_rWOje-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:00:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:00:12 INFO - Running setup.py (path:/tmp/pip-H4xrsj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:00:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:00:13 INFO - Running setup.py (path:/tmp/pip-71g3k4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:00:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:00:13 INFO - Running setup.py (path:/tmp/pip-vbTPvS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:00:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:00:13 INFO - Running setup.py (path:/tmp/pip-aeYQL9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:00:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:00:13 INFO - Running setup.py (path:/tmp/pip-e8I9pj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:00:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:00:13 INFO - Running setup.py (path:/tmp/pip-ommKLr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:00:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:00:13 INFO - Running setup.py (path:/tmp/pip-VJN5vi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:00:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:00:13 INFO - Running setup.py (path:/tmp/pip-LEQ6pj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:00:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:00:13 INFO - Running setup.py (path:/tmp/pip-j4IpIw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:00:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:00:13 INFO - Running setup.py (path:/tmp/pip-NXcwQo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:00:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:00:13 INFO - Running setup.py (path:/tmp/pip-r8F0jl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:00:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:00:13 INFO - Running setup.py (path:/tmp/pip-VO2snl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:00:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:00:13 INFO - Running setup.py (path:/tmp/pip-eSAy4J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:00:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:00:13 INFO - Running setup.py (path:/tmp/pip-QMMwVl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:00:13 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 22:00:13 INFO - Running setup.py install for manifestparser 22:00:14 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 22:00:14 INFO - Running setup.py install for mozcrash 22:00:14 INFO - Running setup.py install for mozdebug 22:00:14 INFO - Running setup.py install for mozdevice 22:00:14 INFO - Installing dm script to /builds/slave/test/build/venv/bin 22:00:14 INFO - Running setup.py install for mozfile 22:00:14 INFO - Running setup.py install for mozhttpd 22:00:14 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 22:00:14 INFO - Running setup.py install for mozinfo 22:00:14 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 22:00:14 INFO - Running setup.py install for mozInstall 22:00:14 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 22:00:14 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 22:00:14 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 22:00:14 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 22:00:14 INFO - Running setup.py install for mozleak 22:00:14 INFO - Running setup.py install for mozlog 22:00:15 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 22:00:15 INFO - Running setup.py install for moznetwork 22:00:15 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 22:00:15 INFO - Running setup.py install for mozprocess 22:00:15 INFO - Running setup.py install for mozprofile 22:00:15 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 22:00:15 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 22:00:15 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 22:00:15 INFO - Running setup.py install for mozrunner 22:00:15 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 22:00:15 INFO - Running setup.py install for mozscreenshot 22:00:15 INFO - Running setup.py install for moztest 22:00:15 INFO - Running setup.py install for mozversion 22:00:15 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 22:00:15 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 22:00:15 INFO - Cleaning up... 22:00:15 INFO - Return code: 0 22:00:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:00:15 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')]} 22:00:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:00:15 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')]} 22:00:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:00:15 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 0x234d3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2527a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26caef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26c7e40>, '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 0x26c8fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26c9440>, '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': '745a4373a2a16df560f216e000000264-1495944412.112491-529162384', '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 22:00:15 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 22:00:15 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 22:00:15 INFO - Using env: {'DISPLAY': ':0', 22:00:15 INFO - 'HOME': '/home/cltbld', 22:00:15 INFO - 'LANG': 'en_US.UTF-8', 22:00:15 INFO - 'LANGUAGE': 'en_US:en', 22:00:15 INFO - 'LOGNAME': 'cltbld', 22:00:15 INFO - 'MAIL': '/var/mail/cltbld', 22:00:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:00:15 INFO - 'MOZ_NO_REMOTE': '1', 22:00:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:00:15 INFO - 'NO_EM_RESTART': '1', 22:00:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:00:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:00:15 INFO - 'PWD': '/builds/slave/test', 22:00:15 INFO - 'SHELL': '/bin/bash', 22:00:15 INFO - 'SHLVL': '1', 22:00:15 INFO - 'TERM': 'linux', 22:00:15 INFO - 'TMOUT': '86400', 22:00:15 INFO - 'USER': 'cltbld', 22:00:15 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1495944412.112491-529162384', 22:00:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:00:15 INFO - '_': '/tools/buildbot/bin/python'} 22:00:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:00:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:00:15 INFO - Running setup.py (path:/tmp/pip-ORP7p9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:00:16 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)) 22:00:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:00:16 INFO - Running setup.py (path:/tmp/pip-3XydrU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:00:16 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)) 22:00:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:00:16 INFO - Running setup.py (path:/tmp/pip-iOVIMQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:00:16 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)) 22:00:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:00:16 INFO - Running setup.py (path:/tmp/pip-1Z2GPJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:00:16 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)) 22:00:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:00:16 INFO - Running setup.py (path:/tmp/pip-NmaQAt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:00:16 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)) 22:00:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:00:16 INFO - Running setup.py (path:/tmp/pip-vOFFdk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:00:16 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)) 22:00:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:00:16 INFO - Running setup.py (path:/tmp/pip-mvJydj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:00:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 22:00:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:00:16 INFO - Running setup.py (path:/tmp/pip-UCrpYD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:00:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 22:00:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:00:16 INFO - Running setup.py (path:/tmp/pip-NGsYmx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:00:16 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)) 22:00:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:00:16 INFO - Running setup.py (path:/tmp/pip-u3GstC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:00:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 22:00:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:00:16 INFO - Running setup.py (path:/tmp/pip-jCySQy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:00:16 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)) 22:00:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:00:16 INFO - Running setup.py (path:/tmp/pip-HM8G0z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:00:16 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)) 22:00:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:00:16 INFO - Running setup.py (path:/tmp/pip-qLuqJv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:00:16 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)) 22:00:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:00:16 INFO - Running setup.py (path:/tmp/pip-QIe2sS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:00:16 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)) 22:00:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:00:17 INFO - Running setup.py (path:/tmp/pip-S0Xy98-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:00:17 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)) 22:00:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:00:17 INFO - Running setup.py (path:/tmp/pip-IAjqYO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:00:17 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)) 22:00:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:00:17 INFO - Running setup.py (path:/tmp/pip-oJ8qcT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:00:17 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)) 22:00:17 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)) 22:00:17 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)) 22:00:17 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)) 22:00:17 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)) 22:00:17 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)) 22:00:17 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 22:00:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:00:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:00:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:00:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:00:18 INFO - Downloading blessings-1.6.tar.gz 22:00:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 22:00:18 INFO - Installing collected packages: blessings 22:00:18 INFO - Running setup.py install for blessings 22:00:18 INFO - Successfully installed blessings 22:00:18 INFO - Cleaning up... 22:00:18 INFO - Return code: 0 22:00:18 INFO - Done creating virtualenv /builds/slave/test/build/venv. 22:00:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:00:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:00:18 INFO - Reading from file tmpfile_stdout 22:00:18 INFO - Current package versions: 22:00:18 INFO - argparse == 1.2.1 22:00:18 INFO - blessings == 1.6 22:00:18 INFO - blobuploader == 1.2.4 22:00:18 INFO - docopt == 0.6.1 22:00:18 INFO - functools32 == 3.2.3-2 22:00:18 INFO - jsonschema == 2.5.1 22:00:18 INFO - manifestparser == 1.1 22:00:18 INFO - mozInstall == 1.12 22:00:18 INFO - mozcrash == 1.0 22:00:18 INFO - mozdebug == 0.1 22:00:18 INFO - mozdevice == 0.51 22:00:18 INFO - mozfile == 1.2 22:00:18 INFO - mozhttpd == 0.7 22:00:18 INFO - mozinfo == 0.9 22:00:18 INFO - mozleak == 0.1 22:00:18 INFO - mozlog == 3.4 22:00:18 INFO - moznetwork == 0.27 22:00:18 INFO - mozprocess == 0.25 22:00:18 INFO - mozprofile == 0.28 22:00:18 INFO - mozrunner == 6.13 22:00:18 INFO - mozscreenshot == 0.1 22:00:18 INFO - mozsystemmonitor == 0.3 22:00:18 INFO - moztest == 0.8 22:00:18 INFO - mozversion == 1.4 22:00:18 INFO - psutil == 3.1.1 22:00:18 INFO - requests == 1.2.3 22:00:18 INFO - wsgiref == 0.1.2 22:00:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:00:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:00:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:00:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:00:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:00:18 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 0x234d3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2527a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26caef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26c7e40>, '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 0x26c8fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26c9440>, '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': '745a4373a2a16df560f216e000000264-1495944412.112491-529162384', '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 22:00:18 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 22:00:18 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 22:00:18 INFO - Using env: {'DISPLAY': ':0', 22:00:18 INFO - 'HOME': '/home/cltbld', 22:00:18 INFO - 'LANG': 'en_US.UTF-8', 22:00:18 INFO - 'LANGUAGE': 'en_US:en', 22:00:18 INFO - 'LOGNAME': 'cltbld', 22:00:18 INFO - 'MAIL': '/var/mail/cltbld', 22:00:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:00:18 INFO - 'MOZ_NO_REMOTE': '1', 22:00:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:00:18 INFO - 'NO_EM_RESTART': '1', 22:00:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:00:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:00:18 INFO - 'PWD': '/builds/slave/test', 22:00:18 INFO - 'SHELL': '/bin/bash', 22:00:18 INFO - 'SHLVL': '1', 22:00:18 INFO - 'TERM': 'linux', 22:00:18 INFO - 'TMOUT': '86400', 22:00:18 INFO - 'USER': 'cltbld', 22:00:18 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1495944412.112491-529162384', 22:00:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:00:18 INFO - '_': '/tools/buildbot/bin/python'} 22:00:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:00:18 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)) 22:00:18 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)) 22:00:18 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)) 22:00:18 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)) 22:00:18 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)) 22:00:18 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)) 22:00:18 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)) 22:00:18 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)) 22:00:18 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)) 22:00:18 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 22:00:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:00:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:00:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:00:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:00:20 INFO - Downloading marionette_driver-1.4.0.tar.gz 22:00:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 22:00:20 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)) 22:00:20 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)) 22:00:20 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)) 22:00:20 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)) 22:00:20 INFO - Installing collected packages: marionette-driver 22:00:20 INFO - Running setup.py install for marionette-driver 22:00:20 INFO - Successfully installed marionette-driver 22:00:20 INFO - Cleaning up... 22:00:20 INFO - Return code: 0 22:00:20 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 22:00:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:00:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:00:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:00:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:00:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x234d3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2527a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26caef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26c7e40>, '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 0x26c8fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26c9440>, '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': '745a4373a2a16df560f216e000000264-1495944412.112491-529162384', '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 22:00:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 22:00:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 22:00:20 INFO - Using env: {'DISPLAY': ':0', 22:00:20 INFO - 'HOME': '/home/cltbld', 22:00:20 INFO - 'LANG': 'en_US.UTF-8', 22:00:20 INFO - 'LANGUAGE': 'en_US:en', 22:00:20 INFO - 'LOGNAME': 'cltbld', 22:00:20 INFO - 'MAIL': '/var/mail/cltbld', 22:00:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:00:20 INFO - 'MOZ_NO_REMOTE': '1', 22:00:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:00:20 INFO - 'NO_EM_RESTART': '1', 22:00:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:00:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:00:20 INFO - 'PWD': '/builds/slave/test', 22:00:20 INFO - 'SHELL': '/bin/bash', 22:00:20 INFO - 'SHLVL': '1', 22:00:20 INFO - 'TERM': 'linux', 22:00:20 INFO - 'TMOUT': '86400', 22:00:20 INFO - 'USER': 'cltbld', 22:00:20 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1495944412.112491-529162384', 22:00:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:00:20 INFO - '_': '/tools/buildbot/bin/python'} 22:00:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:00:20 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 22:00:20 INFO - Cleaning up... 22:00:20 INFO - Return code: 0 22:00:20 INFO - Running post-action listener: _resource_record_post_action 22:00:20 INFO - Running post-action listener: _start_resource_monitoring 22:00:20 INFO - Starting resource monitoring. 22:00:20 INFO - [mozharness: 2017-05-28 05:00:20.541602Z] Finished create-virtualenv step (success) 22:00:20 INFO - [mozharness: 2017-05-28 05:00:20.542118Z] Running install step. 22:00:20 INFO - Running pre-action listener: _resource_record_pre_action 22:00:20 INFO - Running main action method: install 22:00:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:00:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:00:20 INFO - Reading from file tmpfile_stdout 22:00:20 INFO - Detecting whether we're running mozinstall >=1.0... 22:00:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 22:00:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 22:00:20 INFO - Reading from file tmpfile_stdout 22:00:20 INFO - Output received: 22:00:20 INFO - Usage: mozinstall [options] installer 22:00:20 INFO - Options: 22:00:20 INFO - -h, --help show this help message and exit 22:00:20 INFO - -d DEST, --destination=DEST 22:00:20 INFO - Directory to install application into. [default: 22:00:20 INFO - "/builds/slave/test"] 22:00:20 INFO - --app=APP Application being installed. [default: firefox] 22:00:20 INFO - mkdir: /builds/slave/test/build/application 22:00:20 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'] 22:00:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 22:00:36 INFO - Reading from file tmpfile_stdout 22:00:36 INFO - Output received: 22:00:36 INFO - /builds/slave/test/build/application/firefox/firefox 22:00:36 INFO - Running post-action listener: _resource_record_post_action 22:00:36 INFO - [mozharness: 2017-05-28 05:00:36.410434Z] Finished install step (success) 22:00:36 INFO - [mozharness: 2017-05-28 05:00:36.410669Z] Running setup-mitmproxy step. 22:00:36 INFO - Running pre-action listener: _resource_record_pre_action 22:00:36 INFO - Running main action method: setup_mitmproxy 22:00:36 INFO - Skipping: mitmproxy is not required 22:00:36 INFO - Running post-action listener: _resource_record_post_action 22:00:36 INFO - [mozharness: 2017-05-28 05:00:36.411260Z] Finished setup-mitmproxy step (success) 22:00:36 INFO - [mozharness: 2017-05-28 05:00:36.411363Z] Running run-tests step. 22:00:36 INFO - Running pre-action listener: _resource_record_pre_action 22:00:36 INFO - Running main action method: run_tests 22:00:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 22:00:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 22:00:36 INFO - Python 2.7.3 22:00:36 INFO - Return code: 0 22:00:36 INFO - grabbing minidump binary from tooltool 22:00:36 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')]} 22:00:36 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 0x26c7e40>, '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 0x26c8fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26c9440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 22:00:36 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 22:00:36 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 22:00:36 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 22:00:36 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 22:00:36 INFO - Return code: 0 22:00:36 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 22:00:36 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 22:00:36 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 22:00:36 INFO - ENV: RUST_BACKTRACE is now 1 22:00:36 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 22:00:36 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 22:00:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/R8Wmzd1jQ_-NCuyrMuTTjA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-032', '--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 22:00:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/R8Wmzd1jQ_-NCuyrMuTTjA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-032 --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 22:00:36 INFO - Using env: {'DISPLAY': ':0', 22:00:36 INFO - 'HOME': '/home/cltbld', 22:00:36 INFO - 'LANG': 'en_US.UTF-8', 22:00:36 INFO - 'LANGUAGE': 'en_US:en', 22:00:36 INFO - 'LOGNAME': 'cltbld', 22:00:36 INFO - 'MAIL': '/var/mail/cltbld', 22:00:36 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 22:00:36 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 22:00:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:00:36 INFO - 'MOZ_NO_REMOTE': '1', 22:00:36 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 22:00:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:00:36 INFO - 'NO_EM_RESTART': '1', 22:00:36 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:00:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:00:36 INFO - 'PWD': '/builds/slave/test', 22:00:36 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 22:00:36 INFO - 'RUST_BACKTRACE': '1', 22:00:36 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 22:00:36 INFO - 'SHELL': '/bin/bash', 22:00:36 INFO - 'SHLVL': '1', 22:00:36 INFO - 'TERM': 'linux', 22:00:36 INFO - 'TMOUT': '86400', 22:00:36 INFO - 'USER': 'cltbld', 22:00:36 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1495944412.112491-529162384', 22:00:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:00:36 INFO - '_': '/tools/buildbot/bin/python'} 22:00:36 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/R8Wmzd1jQ_-NCuyrMuTTjA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-032', '--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 22:00:36 INFO - mozversion application_buildid: 20170528042900 22:00:36 INFO - mozversion application_changeset: ee96ce3c71b79064efe8ab2c7ff35e6b6220a475 22:00:36 INFO - mozversion application_display_name: Nightly 22:00:36 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:00:36 INFO - mozversion application_name: Firefox 22:00:36 INFO - mozversion application_remotingname: firefox 22:00:36 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 22:00:36 INFO - mozversion application_vendor: Mozilla 22:00:36 INFO - mozversion application_version: 55.0a1 22:00:36 INFO - mozversion platform_buildid: 20170528042900 22:00:36 INFO - mozversion platform_changeset: ee96ce3c71b79064efe8ab2c7ff35e6b6220a475 22:00:36 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 22:00:36 INFO - mozversion platform_version: 55.0a1 22:00:36 INFO - using testdate: 1495947636 22:00:36 INFO - actual date: 1495947636 22:00:36 INFO - starting webserver on 'localhost:47309' 22:00:36 INFO - SUITE-START | Running 2 tests 22:00:36 INFO - TEST-START | dromaeo_css 22:00:36 INFO - operating with platform_type : linux_ 22:00:36 INFO - Initialising browser for dromaeo_css test... 22:00:36 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:47309/getInfo.html -profile /tmp/tmptLBW7F/profile 22:00:36 INFO - TEST-INFO | started process 8045 (/builds/slave/test/build/application/firefox/firefox http://localhost:47309/getInfo.html) 22:01:12 INFO - TEST-INFO | 8045: killed by SIGTERM 22:01:12 INFO - Browser initialized. 22:01:12 INFO - Running cycle 1/1 for dromaeo_css test... 22:01:12 INFO - TEST-INFO | started process 8243 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmptLBW7F/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:01:24 INFO - PID 8243 | RSS: Main: 183615488 22:01:24 INFO - PID 8243 | 22:04:29 INFO - PID 8243 | Cycle 1(1): loaded http://localhost:47309/tests/dromaeo/cssquery-dojo.html (next: http://localhost:47309/tests/dromaeo/cssquery-ext.html) 22:04:30 INFO - PID 8243 | RSS: Main: 180342784 22:04:30 INFO - PID 8243 | 22:07:32 INFO - PID 8243 | Cycle 1(1): loaded http://localhost:47309/tests/dromaeo/cssquery-ext.html (next: http://localhost:47309/tests/dromaeo/cssquery-jquery.html) 22:07:33 INFO - PID 8243 | RSS: Main: 183644160 22:07:33 INFO - PID 8243 | 22:10:35 INFO - PID 8243 | Cycle 1(1): loaded http://localhost:47309/tests/dromaeo/cssquery-jquery.html (next: http://localhost:47309/tests/dromaeo/cssquery-mootools.html) 22:10:35 INFO - PID 8243 | RSS: Main: 180903936 22:10:35 INFO - PID 8243 | 22:13:37 INFO - PID 8243 | Cycle 1(1): loaded http://localhost:47309/tests/dromaeo/cssquery-mootools.html (next: http://localhost:47309/tests/dromaeo/cssquery-prototype.html) 22:13:38 INFO - PID 8243 | RSS: Main: 185053184 22:13:38 INFO - PID 8243 | 22:16:41 INFO - PID 8243 | Cycle 1(1): loaded http://localhost:47309/tests/dromaeo/cssquery-prototype.html (next: http://localhost:47309/tests/dromaeo/cssquery-yui.html) 22:16:41 INFO - PID 8243 | RSS: Main: 183402496 22:16:41 INFO - PID 8243 | 22:19:43 INFO - PID 8243 | Cycle 1(1): loaded http://localhost:47309/tests/dromaeo/cssquery-yui.html (next: http://localhost:47309/tests/dromaeo/cssquery-dojo.html) 22:19:43 INFO - PID 8243 | RSS: Main: 182951936 22:19:43 INFO - PID 8243 | 22:19:43 INFO - PID 8243 | __start_tp_report 22:19:43 INFO - PID 8243 | _x_x_mozilla_page_load 22:19:43 INFO - PID 8243 | _x_x_mozilla_page_load_details 22:19:43 INFO - PID 8243 | |i|pagename|runs| 22:19:43 INFO - PID 8243 | |0;dojo.html;2720.9727902720974;2744.1218809980787;2767.3081729567607;2784.6240757497744;2786.122371452991;5237.5548078413285;5360.383555891069;5376.408595054546;5422.566194704424;5433.1035379162395;5345.973270133653;5350.946490535093;5361.169018802082;5447.782088716446;5452.454754524546;4519.186546421643;4719.575238228559;4776.211925032366;4802.543758342952;4809.831655892044;4851.660383773137;4893.902121957559;4894.583960363373;4911.5088491150955;4914.3611330527165;4675.18184317743;4734.502877197913;4736;4820.132376172288;4848.272759086165;4810.037992401499;4818.277258411232;4838.540338667821;4841.2496063110275;4859.1739404301;4761.904761904742;4780.952190478086;4787.952120478785;4792.424909010906;4792.856214313576;5197.324347834795;5372.194170874361;5382.111951527993;5396.703181325026;5410.161424979135;5738.598298119134;5743.856403589902;5864.091065884794;5864.149698293723;5871.8532036699;5921.082232254007;5922.3781502942;5922.911156332659;5926.4666180044005;5964.463198312129;5465.207544906006;5465.289512363447;5468.097763868917;5470.589705772083;5473.863153421196;5861.648301101947;5891.823245302648;5931.970340148272;5960.940390596125;6037.54718396122;5772.365039845614;5774.364819869811;5776.075827867521;5794.797182098607;5811.970940145272;5612.382637909826;5830.038043722739;5849.970750146222;5865.472107510259;5866.6186697864505;5589.636673616202;5684.63049901755;5797.594168408171;5807.361190269067;5814.418558144152;5676.460736230051;5685.914711279252;5691.03252447085;5770.451807078321;5775.88448231033;4861.465238823726;4875.658703890694;4880.755962201875;4893.168161412568;4921.360223170965;4112.074783173822;4149.170165966819;4158.896027599334;4202.915941681211;4226.387173859835;4702.623790096784;4814.15752243356;4817.229243321051;4894.681845680019;4927.063857866994;5708;5737.995850726106;5788.218590490314;5802.071668533099;5808.767649294065;4894.412670479494;4902.975485122623;4904;4906.975465122651;4934.777934992934;5158;5159.1487404578575;5162.1224391853475;5164.561012313995;5215.087359712035;5248.3701955765555;5325.653832500875;5329.57363410934;5405.621606487665;5412.269343638558;5731.484166425042;5825.41745825431;5874;5885.47030767233;5886.323072846678;5265.183896496049;5337.706426146444;5344.4121146674615;5358.678479291255;5366.812161574482;5583.609147359646;5719.428057194247;5724.112762521816;5727.02640551099;5764.481196692318;5692.345380281321;5719.685417302088;5774.393688662798;5831.679257640871;5891.941080589139;5678.4605462480995;5678.716064196857;5682.545396368363;5722.313322401338;5734;5682.659040457585;5682.715864206856;5686.061799802987;5690.573207009574;5691.2032315475035;5421.972890135524;5519.862003449946;5531.695756733257;5537;5593.384727680033;5621.100623900156;5642.266505354278;5709.400512946247;5721.5136713379825;5731.656100633975;5507.9449205507435;5513.889722205614;5520.199571062254;5539.14143307788;5569.805056822992 22:19:43 INFO - PID 8243 | |1;ext.html;666.7599664120916;724.8079258996366;746.7274444827638;1089.3463921647012;1102.167863263236;31978.840105799467;32585.837070814643;32778.836105819464;32780.67219327806;32973.67026329736;34114.48828267578;34302;34379;34419.31161376777;34547.481787773206;6482.7406903723795;6729.966350168254;6756.223034351064;6854.417374523172;6869;6717.764878229263;6748.156480439945;6748.561343512681;6780.660966951657;6831.180258368978;6758.9324106758795;6795.728170873159;6824.931750682504;6838.452923766112;6856.451483881277;6731.528792984493;6731.5624484408845;6747.325267473262;6761.560498567577;6810.387065164135;6623.172103487064;6665.6667166641955;6697.162854643169;6708.530402871801;6710.396064354231;31234.687653123405;31538.842305788552;31551.211219719462;31576.052718418483;31764.20589485258;3073.477508823483;3119.3605310911207;3130.264387868849;3138.5135304027913;3138.8587513561943;24276.271711848498;24329.39176520601;24331.513369732682;24379.878100609385;24395.14616988397;2928.180109569324;2931.428371467565;2939.9853000735075;2940.970590294091;2947.2189869684553;113070;114270;129853;130508;130530;37563.24873502569;37897.43153852639;38390.616093839264;38396.6160338393;38402.80798596045;39622.405663915066;39978.40032399516;40060.19879602391;40129;40278;12505.437255323532;12618.116731828868;12665.176763510342;12671;12671.17637353569;10254.461830725451;10325.741856453498;10355.326903751233;10359.585616575252;10377.429241391796;12470.43883025266;12558.686032849251;12581.559645412366;12584.37078146089;12668.303243321705;5325.201219817059;5331.973340133274;5332.200169974535;5416.837494875082;5448.591355648342;860.3762272352494;914.5381582301028;916.6287653500343;927.4667066436825;935.373299889076;20540.383788486368;21287.68068478974;21516;21531.354059378245;21760.673589896163;987.8814542254831;993.1607791416242;1010.782681723433;1017.2675673515057;1018.7198520406799;10904.34573925567;11106.44467776608;11198.104151667847;11293.604723834791;11329.37688427128;169050;170045;170302;170629;171051;40431.393529097084;40648.39027414591;40654;40660.59339406627;40671;1210.3403645013489;1256.2839181666363;1258.534342293339;1261.7224210673821;1265.1649911058657;19919.701204481655;20382.18471261192;20884.47788805231;20926;21253.46866328354;28787.568186477638;28869.27826804347;31934.201644959063;32420.75792420739;32441;149718;150775.24612376868;151119;151697;152501;28845.711542884303;29924.251893702833;30042.3991520164;30128;30146.8750312443;35023.29953400969;35944.460833087;36023.27953440969;36586;37228.25543489061;27414.5887811679;27497.45005099847;27702.584461232695;28140.01509947142;28536.85731571329;27410.72589274082;27526.311842204104;28237.717622823508;28426.147215583565;28888.711112888603;30458.390832183675;30806.845965770026;30847.2288192797;30867.38265234638;30891;25946.870265649308;26214.60678089792;26290.868545657915;26708.46583068289;27709.861450692617;19716.802831971498;22057.33827985163;22394.552108958054;22405.43986400353;22504.88747556252 22:19:43 INFO - PID 8243 | |2;jquery.html;407.31164332278445;407.6575676431797;421.1240619511416;433.49930829891485;433.79611582556197;17084.48746537604;17881.105944702762;17929.103544822756;18166.27334906602;18693.158807853644;18553.628927421476;18918;19037.428877133672;19170;19171.32900348488;5470.507654311111;5544.972275138619;5644;5655.5475561954945;5677.6373670319035;5547.77808887644;5605.131204663284;5620.072688006474;5620.606557540974;5640.04119299718;5091;5336.733163341837;5560.2493663355335;5593.440655934414;5599.720013999304;5275.498827611371;5275.86810329741;5299.152135658314;5326.387465441485;5332.33345831771;4677.812887484531;4829.492903245144;4833.637477189225;4836.564709176191;4854.053459575384;21836.672449913265;21917.671234931488;22009.779902200935;22164.88917555402;22363;1632.5510484616707;1657.5938894970689;1658.8009438867293;1661.3852874436536;1664.1097013098056;14584.781228281585;14610.707785844224;15140.924295378563;15241.771373429407;15270.236488175658;1956.1686283329527;1989.801019898013;2018.6265540874986;2021.9696704549444;2028.1988614497338;89837.55081224552;90424.5478772602;90622;91447;92025.53987230088;10694.223583219677;10958.506867190836;10979.231453798317;10996.725081872857;11277.928596783293;14691.853081469262;14723.043002204822;14745.11529308245;14808.555743327717;14815.814734821404;7328.853422931512;7618.961905190438;7748.690052397841;7787.805304867424;8061.4760040597175;6893.586384816927;6950.721971121199;7029.929700702927;7141.178764442052;7171.713131474683;6968.58188508681;6992.6853291602;7026.718931242795;7051.471139664545;7065.2228254891925;1926.7687877454796;1938.2440848069264;1946.5717542140706;1963.6956271777897;2078.4803799050237;833.8374017066614;869.2524428991063;887.3078998381272;900.6307413960245;906.9183773460288;16874.409395671093;17030.659386812193;17160.313587456363;17333.653326933392;17832.375866844857;873.3973558244791;878.6748902905838;879.6965047058754;888.5424006636588;907.2605826251583;9344.766380840398;11061.281016733887;11989;12051.75896482083;12185.45165467556;370448;372739;374829;378808;386201;78111;78192;78503.60748196336;79134;81900;1036.7978244242452;1042.744527590745;1075.3547871277171;1078.7626722121122;1088.0479580367178;17490.775645704678;17501;18119.456416307006;18571.628567428306;18828;38699;38909.6109038906;39124.80437597794;39569.60430395659;39667.603323967545;49189.508104918496;49536.75231623819;50914.74542627263;51961.48038519567;52518;7898.091719452336;8212.3430125591;8308.127646597262;8476.237138657303;8499.660013599387;11064.446777661246;12634.936825315815;12817.295048772407;12877.871221287667;13439.932800336326;10114.241431892784;10654.73363165927;10874.184436167478;11369;11906.464209110783;10658.573657053632;10721.946390268311;10857.40284284372;10873.510692018719;10924.617638382937;10739.838902416313;10847.349159050482;11055.391953442639;11205.66383008511;11444.82832757526;8163.918360816316;8210.753677389688;8234.711785087493;8237.217464340878;8291.792705182419;10541;10602.89397106019;11183.776324473301;11520.94239528797;11541.192116551762 22:19:43 INFO - PID 8243 | |3;mootools.html;1252.94988200472;1318.749437606854;1320.4190156331213;1324.9933750331247;1336.7326534693061;10309.793804123923;10728.946355268232;10790.622328218515;10804.891951080486;11074.944625276883;10857.45712714365;11094.889051109487;11105.944470277638;11138.721531961684;11163.162762792783;2110.7572629147653;2153.5908177446313;2167.794059564339;2171.5873983943;2172.174573662014;2171.576542574199;2207.1833421633937;2210.06072419222;2212.4358288636454;2218.9889050554725;2144.485323522359;2177.8693278403266;2180.1824315881545;2184.464806122502;2204.9967264894512;2124.129107066103;2124.3945475539476;2138.219549864304;2141.967870481944;2152.4726442021806;1851.879627824187;1912.6270377276437;1941.2526177421653;1963.6072785442825;1970.270999730109;10336.224783141295;10677.092447142002;10688.625898093529;10701.09040731531;10704.839427408595;5696.772129114872;5941.287045554518;5941.910871336933;5961.046232602763;5962.612430192024;3283.277678910636;3380.4760262159402;3390.3727810355163;3455.6198818129988;3474.774139680913;1098.741795678015;1116.8492253545749;1132.224426268009;1138.7893239750672;1159.9884001159965;15140.242987850563;15270;15282.083075015535;15285.770713439308;15299.847001529954;4745.976270118696;4874.439439464436;4986.576141028053;5006.774695138727;5019.196928491424;11064.944675276573;11088.22382433238;11096.889031109748;11133.498992545356;11160.609378671708;5523.640963337451;5662.915056274159;5709.54323654115;5723.627964182315;5725.484706376446;5183.714895680699;5248.239005344204;5264.0259902536545;5270.288511050959;5320.414754377015;3795.69634429245;3803.2963901678277;3856.5757766645647;3957.426173204869;3964.7819369934355;1151.1136424952906;1152.8040233160382;1154.3593305715408;1160.9535618575162;1174.3188950408742;676.5940435738518;703.7325816189917;709.2942522190453;723.4754802768057;728.7595093619093;5294.788208471618;5347.1979203119845;5407.134858422633;5467.152591348347;5504.284443022381;535.7642637239602;536.2840607788646;547.7671989404487;548.5501888451431;549.8982688202695;3428.8457019434186;3429.8852872816433;3471.7743346682387;3481.112316359312;3593.766405183707;13932.791008134885;14186.85813141876;14508.202048887413;14512.274386280644;14516.637084072983;14132.505362312475;14387.064840785315;14506.709865802624;14510.419583216553;14516.782248266285;7285.777837759429;7558.622068896533;7778.22217778229;7836.098848632366;7852.450328477066;5707.343655479507;5957.3744756799915;6067.605605635619;6151.6001459904965;6338.176037115146;12375.504979800708;12680.492780289054;12730.872691272969;12891.48434062627;12915.935420322838;13071.411786469822;13143.474261029452;13158.14472059313;13185.80221296662;13405.396757145756;9137.40606860552;9490.240780737662;9627.807443850943;9681.70954871355;9683.370580912218;10044.447555384524;10210.38737675712;10223.233257505866;10229.84655230187;10240.129588984722;8343;8356.415050946376;8440.282575981111;8829.072947340694;8864;7522.172561018393;7592.088949326117;8046.235607617267;8142.47073940192;8312.709055183039;7307.853842923006;7396.55620662762;7463.962680186564;7636.045494313211;7729.227077292226;4842.709437433765;5220.817271395635;5289.285946397187;5433.347998240237;5528.308961379827;5362.490563396471;5411.242426060276;5422.213779002102;5487.506124448819;5489.231507589021 22:19:43 INFO - PID 8243 | |4;prototype.html;374.8744170702814;384.42912275271215;392.53876694883525;394.02871920715467;400.67545288316467;5412.161115027177;5527.2538207341995;5544.6673199608;5563.527100196483;5609.49514543691;5330.440303768107;5467.926394835843;5470.042742520063;5484.7933454639915;5499.862503437416;4316.6978311518205;4323.805428755698;4335.089631177457;4338.84814031509;4357.17213729392;4234.6823988201;4346.8913277168;4354.564543545636;4360.585744354281;4366.694331396803;4347.760873151976;4353.434053573031;4353.782310884459;4358.629516491086;4374.278244089722;4333.393324934512;4333.60997510224;4336.392904993272;4337.891552711176;4346.826126954918;3914.178022615254;3957.7823219722904;3962;3977.9204415911518;3982.880513584597;5396.217548455491;5407.242985981966;5407.594430417695;5425.864353391157;5435.130379139358;5093.821716239914;5130.692158470503;5137.434882162959;5142.074426603247;5175.948240517622;5655.660660360391;5829.571754920072;5836.418411546958;5837.664934026381;5869.647821130746;4419.734815911055;4420.093880754438;4428.095918754934;4445.11097780442;4450.1767173073085;5907.556933229982;5988.352928249596;6051.515878729691;6178.887800195963;6230.501559875199;4541.863744087683;4569.948911750316;4575.153596584576;4575.954240457553;4583.427071616048;4639.489656137822;4675.602573781199;4676.18166820805;4682.1338052460405;4700.083483720641;5001.349554646958;5118.87202819925;5123.205903085028;5150.716710580879;5151.742412879341;5832.795852145155;5840.2115714378015;5856.443637854397;5867.20792692981;5879.676617786063;1561.1725785333792;1561.461295852929;1574.9291281892342;1577.846239882552;1590.658008528172;1125.8874112588676;1164.6389619218069;1169.5497233565138;1170.5785917069848;1176.335370515656;4958.479359667183;4967.82612608557;4976.651634385558;4981.90036199274;4996.500349964975;5938.524918006549;5940.405959404025;5946.881062378815;5948.524118070544;5969.253843269591;4812.494688057704;4961.7519124044375;4983.8504844854715;4989.925151122736;4992.450830408652;3154.3848949455096;3168.6672899345235;3172.5558421820965;3177.459831828595;3180.681931806847;5433.782648694087;5534.833954981357;5552.444755524415;5553.750081246273;5564.777408903598;6152.938470615237;6155.538334624921;6174.5060395168275;6179.351168127372;6191.628502289877;5505.697186654773;5514.476124768141;5518.034343989866;5537.252470916455;5560.332760068737;5782.85542861415;5933.940660593339;5979.551533634908;6001.4298641628975;6008.1588577598295;5633.690147041952;5874.148248503858;5896.9115463268945;5901.970490147522;5938.673372964356;5356.464353564613;5430.674159550282;5495.450454954473;5511.421300763523;5527.640703354269;4154.7951094182345;4166.604172603597;4168.374743788456;4173.2905406081645;4182.64447521964;5866.354700982974;5879.5002424792665;6032.276126864805;6045.21412216409;6072.817815465543;5764.798232061858;5787.652740835563;5802.274715660543;5804.8970695567705;5831.970840145942;5723.5707321950185;5768.423157684198;5785.334686511105;5792.53659707214;5815;5665.603407761582;5724.74238659253;5730.71346432685;5745.770169193353;5757.596968212185;5804.6807425590305;5817.360090389969;5841.386654401226;5898.1152827076285;5902.350741418355;5418.187271909245;5547.7780888764;5565.220869078251;5596.384397716167;5693.28833895763 22:19:43 INFO - PID 8243 | |5;yui.html;741.2994719989605;752.8343764371838;768.55039801716;769.7036640893258;778.2023425988359;11909.583164589241;12447.439865206064;13594.320283985799;14703.779443308345;14745.705085898275;15469.84530154698;15983.120928348937;16010.5997350066;16076.115813630246;16091;882.6513527156769;897.8832751742265;900.0729248873671;900.0819164452255;901.6078006067381;906.7869050773063;911.3939230411768;912.1015799437548;912.1835956818643;918.7197904639082;943.5989704375613;950.6197520991624;950.9667161649344;951.281782254397;951.6526467839224;942.5946842857569;945.1871390604075;945.4091193004373;948.9335746497748;950.2255661635745;691.325957191739;692.7332976803967;693.6462404173857;697.1251079894699;701.5790525684548;13713.314334283346;14056.508022219174;14092;14135.575932722035;14313.928430357782;14967.550973470814;15647.608809779733;15750;15820.604484887856;15832.525024249291;11703.53185872564;11802.940985295105;11954;11968.162228643998;12031.578894738643;2902.6661933877454;2955.0543825975697;2956.63042119735;2958.319586495118;2960.5263157894847;71042;71315.64342178256;71547.28452715458;71966;78450.60774696147;12155.574554890536;12629.936850315873;12667.683307917376;12733.36333183337;12977.221366717838;21839.78160218409;22081.227157049427;22246.332610021724;22248.221312254318;23293.53412931732;6003.189569408161;6103.84740381494;6130.938690613126;6135.631862088199;6148.1699970503405;2968.732814046746;3039.7416219621136;3050.3136794221123;3061.0969763919697;3075.1543325585644;3590.0665826885197;3592.2815436912724;3668.614795446493;3674.889753307405;3696.2792255510453;651.9837004074936;659.5482094765101;669.1067424987599;688.0539258519535;764.1059959846992;536.1823219590157;550.9862253443616;561.91290349995;577.5721095299411;585.783260193731;9540.95229523848;10073.848892266622;10280.691579252634;10280.742981425525;10344.689659310232;585.9209006784115;586.2378907420336;616.556079622671;624.6345887655682;644.5069521815815;4216.915661686749;4414.271645178574;4435.933460998088;4447.866564003085;4543.522930092358;80556.59721701354;81017;81662.59168704237;84693.57653211695;84884;73400.26599734041;75111.62444187744;75409;76556;76732;61813;62438.375616243255;66391.66804165948;67414.32585674178;68032;8496.277816385676;8986.101389860962;8997.730068097968;9057.547122643973;9246.95376523113;26480.470390592465;26834.59748103741;27160.72839271582;27929.301767455978;27933.86033069903;48414.75792621014;49104.143337067326;49107;49610.25584616306;50435.74782126066;15134.167620780963;15361.539153825403;15493.070415774639;15610.721748432956;15673.451429200379;15962.28169732388;16098.839011609734;16139.515814525583;16291.674166516841;16459.25933332979;11654.475548600163;15012.549623511311;15049.924750376178;15170.924145379202;15452;14104.717905641624;14107.083039602392;14163.291835407983;14281.64295892611;14285.142891426547;15452.613684657974;15464.84535154679;15900.76148857745;16131.596710082342;16447.0954097521;9889.357191782512;10061.144802691853;10241.129503992244;10346.275760696679;10443.164546836388;10731.40977246259;11018.834717479405;11358.26171298863;11474.196806223485;11503.942480287546 22:19:43 INFO - PID 8243 | __end_tp_report 22:19:43 INFO - PID 8243 | __start_cc_report 22:19:43 INFO - PID 8243 | _x_x_mozilla_cycle_collect,394 22:19:43 INFO - PID 8243 | __end_cc_report 22:19:43 INFO - PID 8243 | __startTimestamp1495948783931__endTimestamp 22:19:43 INFO - PID 8243 | 22:19:43 INFO - PID 8243 | ------- Summary: start ------- 22:19:43 INFO - PID 8243 | Number of tests: 6 22:19:43 INFO - PID 8243 | 22:19:43 INFO - PID 8243 | [#0] dojo.html Cycles:165 Average:5301.06 Median:5465.29 stddev:631.75 (11.6%) stddev-sans-first:600.39 22:19:43 INFO - PID 8243 | Values: 2721.0 2744.1 2767.3 2784.6 2786.1 5237.6 5360.4 5376.4 5422.6 5433.1 5346.0 5350.9 5361.2 5447.8 5452.5 4519.2 4719.6 4776.2 4802.5 4809.8 4851.7 4893.9 4894.6 4911.5 4914.4 4675.2 4734.5 4736.0 4820.1 4848.3 4810.0 4818.3 4838.5 4841.2 4859.2 4761.9 4781.0 4788.0 4792.4 4792.9 5197.3 5372.2 5382.1 5396.7 5410.2 5738.6 5743.9 5864.1 5864.1 5871.9 5921.1 5922.4 5922.9 5926.5 5964.5 5465.2 5465.3 5468.1 5470.6 5473.9 5861.6 5891.8 5932.0 5960.9 6037.5 5772.4 5774.4 5776.1 5794.8 5812.0 5612.4 5830.0 5850.0 5865.5 5866.6 5589.6 5684.6 5797.6 5807.4 5814.4 5676.5 5685.9 5691.0 5770.5 5775.9 4861.5 4875.7 4880.8 4893.2 4921.4 4112.1 4149.2 4158.9 4202.9 4226.4 4702.6 4814.2 4817.2 4894.7 4927.1 5708.0 5738.0 5788.2 5802.1 5808.8 4894.4 4903.0 4904.0 4907.0 4934.8 5158.0 5159.1 5162.1 5164.6 5215.1 5248.4 5325.7 5329.6 5405.6 5412.3 5731.5 5825.4 5874.0 5885.5 5886.3 5265.2 5337.7 5344.4 5358.7 5366.8 5583.6 5719.4 5724.1 5727.0 5764.5 5692.3 5719.7 5774.4 5831.7 5891.9 5678.5 5678.7 5682.5 5722.3 5734.0 5682.7 5682.7 5686.1 5690.6 5691.2 5422.0 5519.9 5531.7 5537.0 5593.4 5621.1 5642.3 5709.4 5721.5 5731.7 5507.9 5513.9 5520.2 5539.1 5569.8 22:19:43 INFO - PID 8243 | 22:19:43 INFO - PID 8243 | [#1] ext.html Cycles:180 Average:29348.19 Median:30137.44 stddev:38574.53 (128.0%) stddev-sans-first:38622.62 22:19:43 INFO - PID 8243 | Values: 666.8 724.8 746.7 1089.3 1102.2 31978.8 32585.8 32778.8 32780.7 32973.7 34114.5 34302.0 34379.0 34419.3 34547.5 6482.7 6730.0 6756.2 6854.4 6869.0 6717.8 6748.2 6748.6 6780.7 6831.2 6758.9 6795.7 6824.9 6838.5 6856.5 6731.5 6731.6 6747.3 6761.6 6810.4 6623.2 6665.7 6697.2 6708.5 6710.4 31234.7 31538.8 31551.2 31576.1 31764.2 3073.5 3119.4 3130.3 3138.5 3138.9 24276.3 24329.4 24331.5 24379.9 24395.1 2928.2 2931.4 2940.0 2941.0 2947.2 113070.0 114270.0 129853.0 130508.0 130530.0 37563.2 37897.4 38390.6 38396.6 38402.8 39622.4 39978.4 40060.2 40129.0 40278.0 12505.4 12618.1 12665.2 12671.0 12671.2 10254.5 10325.7 10355.3 10359.6 10377.4 12470.4 12558.7 12581.6 12584.4 12668.3 5325.2 5332.0 5332.2 5416.8 5448.6 860.4 914.5 916.6 927.5 935.4 20540.4 21287.7 21516.0 21531.4 21760.7 987.9 993.2 1010.8 1017.3 1018.7 10904.3 11106.4 11198.1 11293.6 11329.4 169050.0 170045.0 170302.0 170629.0 171051.0 40431.4 40648.4 40654.0 40660.6 40671.0 1210.3 1256.3 1258.5 1261.7 1265.2 19919.7 20382.2 20884.5 20926.0 21253.5 28787.6 28869.3 31934.2 32420.8 32441.0 149718.0 150775.2 151119.0 151697.0 152501.0 28845.7 29924.3 30042.4 30128.0 30146.9 35023.3 35944.5 36023.3 36586.0 37228.3 27414.6 27497.5 27702.6 28140.0 28536.9 27410.7 27526.3 28237.7 28426.1 28888.7 30458.4 30806.8 30847.2 30867.4 30891.0 25946.9 26214.6 26290.9 26708.5 27709.9 19716.8 22057.3 22394.6 22405.4 22504.9 22:19:43 INFO - PID 8243 | 22:19:43 INFO - PID 8243 | [#2] jquery.html Cycles:180 Average:25372.82 Median:373784.00 stddev:62738.85 (16.8%) stddev-sans-first:62886.84 22:19:43 INFO - PID 8243 | Values: 407.3 407.7 421.1 433.5 433.8 17084.5 17881.1 17929.1 18166.3 18693.2 18553.6 18918.0 19037.4 19170.0 19171.3 5470.5 5545.0 5644.0 5655.5 5677.6 5547.8 5605.1 5620.1 5620.6 5640.0 5091.0 5336.7 5560.2 5593.4 5599.7 5275.5 5275.9 5299.2 5326.4 5332.3 4677.8 4829.5 4833.6 4836.6 4854.1 21836.7 21917.7 22009.8 22164.9 22363.0 1632.6 1657.6 1658.8 1661.4 1664.1 14584.8 14610.7 15140.9 15241.8 15270.2 1956.2 1989.8 2018.6 2022.0 2028.2 89837.6 90424.5 90622.0 91447.0 92025.5 10694.2 10958.5 10979.2 10996.7 11277.9 14691.9 14723.0 14745.1 14808.6 14815.8 7328.9 7619.0 7748.7 7787.8 8061.5 6893.6 6950.7 7029.9 7141.2 7171.7 6968.6 6992.7 7026.7 7051.5 7065.2 1926.8 1938.2 1946.6 1963.7 2078.5 833.8 869.3 887.3 900.6 906.9 16874.4 17030.7 17160.3 17333.7 17832.4 873.4 878.7 879.7 888.5 907.3 9344.8 11061.3 11989.0 12051.8 12185.5 370448.0 372739.0 374829.0 378808.0 386201.0 78111.0 78192.0 78503.6 79134.0 81900.0 1036.8 1042.7 1075.4 1078.8 1088.0 17490.8 17501.0 18119.5 18571.6 18828.0 38699.0 38909.6 39124.8 39569.6 39667.6 49189.5 49536.8 50914.7 51961.5 52518.0 7898.1 8212.3 8308.1 8476.2 8499.7 11064.4 12634.9 12817.3 12877.9 13439.9 10114.2 10654.7 10874.2 11369.0 11906.5 10658.6 10721.9 10857.4 10873.5 10924.6 10739.8 10847.3 11055.4 11205.7 11444.8 8163.9 8210.8 8234.7 8237.2 8291.8 10541.0 10602.9 11183.8 11520.9 11541.2 22:19:43 INFO - PID 8243 | 22:19:43 INFO - PID 8243 | [#3] mootools.html Cycles:180 Average:6525.88 Median:3331.88 stddev:4349.47 (130.5%) stddev-sans-first:4343.62 22:19:43 INFO - PID 8243 | Values: 1252.9 1318.7 1320.4 1325.0 1336.7 10309.8 10728.9 10790.6 10804.9 11074.9 10857.5 11094.9 11105.9 11138.7 11163.2 2110.8 2153.6 2167.8 2171.6 2172.2 2171.6 2207.2 2210.1 2212.4 2219.0 2144.5 2177.9 2180.2 2184.5 2205.0 2124.1 2124.4 2138.2 2142.0 2152.5 1851.9 1912.6 1941.3 1963.6 1970.3 10336.2 10677.1 10688.6 10701.1 10704.8 5696.8 5941.3 5941.9 5961.0 5962.6 3283.3 3380.5 3390.4 3455.6 3474.8 1098.7 1116.8 1132.2 1138.8 1160.0 15140.2 15270.0 15282.1 15285.8 15299.8 4746.0 4874.4 4986.6 5006.8 5019.2 11064.9 11088.2 11096.9 11133.5 11160.6 5523.6 5662.9 5709.5 5723.6 5725.5 5183.7 5248.2 5264.0 5270.3 5320.4 3795.7 3803.3 3856.6 3957.4 3964.8 1151.1 1152.8 1154.4 1161.0 1174.3 676.6 703.7 709.3 723.5 728.8 5294.8 5347.2 5407.1 5467.2 5504.3 535.8 536.3 547.8 548.6 549.9 3428.8 3429.9 3471.8 3481.1 3593.8 13932.8 14186.9 14508.2 14512.3 14516.6 14132.5 14387.1 14506.7 14510.4 14516.8 7285.8 7558.6 7778.2 7836.1 7852.5 5707.3 5957.4 6067.6 6151.6 6338.2 12375.5 12680.5 12730.9 12891.5 12915.9 13071.4 13143.5 13158.1 13185.8 13405.4 9137.4 9490.2 9627.8 9681.7 9683.4 10044.4 10210.4 10223.2 10229.8 10240.1 8343.0 8356.4 8440.3 8829.1 8864.0 7522.2 7592.1 8046.2 8142.5 8312.7 7307.9 7396.6 7464.0 7636.0 7729.2 4842.7 5220.8 5289.3 5433.3 5528.3 5362.5 5411.2 5422.2 5487.5 5489.2 22:19:43 INFO - PID 8243 | 22:19:43 INFO - PID 8243 | [#4] prototype.html Cycles:180 Average:4857.93 Median:5415.17 stddev:1359.95 (25.1%) stddev-sans-first:1321.48 22:19:43 INFO - PID 8243 | Values: 374.9 384.4 392.5 394.0 400.7 5412.2 5527.3 5544.7 5563.5 5609.5 5330.4 5467.9 5470.0 5484.8 5499.9 4316.7 4323.8 4335.1 4338.8 4357.2 4234.7 4346.9 4354.6 4360.6 4366.7 4347.8 4353.4 4353.8 4358.6 4374.3 4333.4 4333.6 4336.4 4337.9 4346.8 3914.2 3957.8 3962.0 3977.9 3982.9 5396.2 5407.2 5407.6 5425.9 5435.1 5093.8 5130.7 5137.4 5142.1 5175.9 5655.7 5829.6 5836.4 5837.7 5869.6 4419.7 4420.1 4428.1 4445.1 4450.2 5907.6 5988.4 6051.5 6178.9 6230.5 4541.9 4569.9 4575.2 4576.0 4583.4 4639.5 4675.6 4676.2 4682.1 4700.1 5001.3 5118.9 5123.2 5150.7 5151.7 5832.8 5840.2 5856.4 5867.2 5879.7 1561.2 1561.5 1574.9 1577.8 1590.7 1125.9 1164.6 1169.5 1170.6 1176.3 4958.5 4967.8 4976.7 4981.9 4996.5 5938.5 5940.4 5946.9 5948.5 5969.3 4812.5 4961.8 4983.9 4989.9 4992.5 3154.4 3168.7 3172.6 3177.5 3180.7 5433.8 5534.8 5552.4 5553.8 5564.8 6152.9 6155.5 6174.5 6179.4 6191.6 5505.7 5514.5 5518.0 5537.3 5560.3 5782.9 5933.9 5979.6 6001.4 6008.2 5633.7 5874.1 5896.9 5902.0 5938.7 5356.5 5430.7 5495.5 5511.4 5527.6 4154.8 4166.6 4168.4 4173.3 4182.6 5866.4 5879.5 6032.3 6045.2 6072.8 5764.8 5787.7 5802.3 5804.9 5832.0 5723.6 5768.4 5785.3 5792.5 5815.0 5665.6 5724.7 5730.7 5745.8 5757.6 5804.7 5817.4 5841.4 5898.1 5902.4 5418.2 5547.8 5565.2 5596.4 5693.3 22:19:43 INFO - PID 8243 | 22:19:43 INFO - PID 8243 | [#5] yui.html Cycles:180 Average:17290.33 Median:3671.75 stddev:22333.48 (608.3%) stddev-sans-first:22361.56 22:19:43 INFO - PID 8243 | Values: 741.3 752.8 768.6 769.7 778.2 11909.6 12447.4 13594.3 14703.8 14745.7 15469.8 15983.1 16010.6 16076.1 16091.0 882.7 897.9 900.1 900.1 901.6 906.8 911.4 912.1 912.2 918.7 943.6 950.6 951.0 951.3 951.7 942.6 945.2 945.4 948.9 950.2 691.3 692.7 693.6 697.1 701.6 13713.3 14056.5 14092.0 14135.6 14313.9 14967.6 15647.6 15750.0 15820.6 15832.5 11703.5 11802.9 11954.0 11968.2 12031.6 2902.7 2955.1 2956.6 2958.3 2960.5 71042.0 71315.6 71547.3 71966.0 78450.6 12155.6 12629.9 12667.7 12733.4 12977.2 21839.8 22081.2 22246.3 22248.2 23293.5 6003.2 6103.8 6130.9 6135.6 6148.2 2968.7 3039.7 3050.3 3061.1 3075.2 3590.1 3592.3 3668.6 3674.9 3696.3 652.0 659.5 669.1 688.1 764.1 536.2 551.0 561.9 577.6 585.8 9541.0 10073.8 10280.7 10280.7 10344.7 585.9 586.2 616.6 624.6 644.5 4216.9 4414.3 4435.9 4447.9 4543.5 80556.6 81017.0 81662.6 84693.6 84884.0 73400.3 75111.6 75409.0 76556.0 76732.0 61813.0 62438.4 66391.7 67414.3 68032.0 8496.3 8986.1 8997.7 9057.5 9247.0 26480.5 26834.6 27160.7 27929.3 27933.9 48414.8 49104.1 49107.0 49610.3 50435.7 15134.2 15361.5 15493.1 15610.7 15673.5 15962.3 16098.8 16139.5 16291.7 16459.3 11654.5 15012.5 15049.9 15170.9 15452.0 14104.7 14107.1 14163.3 14281.6 14285.1 15452.6 15464.8 15900.8 16131.6 16447.1 9889.4 10061.1 10241.1 10346.3 10443.2 10731.4 11018.8 11358.3 11474.2 11503.9 22:19:43 INFO - PID 8243 | -------- Summary: end -------- 22:19:43 INFO - PID 8243 | 22:19:44 INFO - TEST-INFO | 8243: exit 0 22:19:44 INFO - TEST-OK | dromaeo_css | took 1148139ms 22:19:44 INFO - TEST-START | kraken 22:19:44 INFO - operating with platform_type : linux_ 22:19:44 INFO - Initialising browser for kraken test... 22:19:44 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:47309/getInfo.html -profile /tmp/tmpY9CPQB/profile 22:19:44 INFO - TEST-INFO | started process 8650 (/builds/slave/test/build/application/firefox/firefox http://localhost:47309/getInfo.html) 22:20:20 INFO - TEST-INFO | 8650: killed by SIGTERM 22:20:20 INFO - Browser initialized. 22:20:20 INFO - Running cycle 1/1 for kraken test... 22:20:20 INFO - TEST-INFO | started process 8847 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpY9CPQB/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:20:32 INFO - PID 8847 | RSS: Main: 183148544 22:20:32 INFO - PID 8847 | 22:20:35 INFO - PID 8847 | Cycle 1(1): loaded http://localhost:47309/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:47309/tests/kraken/driver.html?testName=audio-beat-detection) 22:20:36 INFO - PID 8847 | RSS: Main: 186560512 22:20:36 INFO - PID 8847 | 22:20:38 INFO - PID 8847 | Cycle 1(1): loaded http://localhost:47309/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:47309/tests/kraken/driver.html?testName=audio-dft) 22:20:39 INFO - PID 8847 | RSS: Main: 185253888 22:20:39 INFO - PID 8847 | 22:20:42 INFO - PID 8847 | Cycle 1(1): loaded http://localhost:47309/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:47309/tests/kraken/driver.html?testName=audio-fft) 22:20:43 INFO - PID 8847 | RSS: Main: 182231040 22:20:43 INFO - PID 8847 | 22:20:45 INFO - PID 8847 | Cycle 1(1): loaded http://localhost:47309/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:47309/tests/kraken/driver.html?testName=audio-oscillator) 22:20:45 INFO - PID 8847 | RSS: Main: 182534144 22:20:45 INFO - PID 8847 | 22:20:47 INFO - PID 8847 | Cycle 1(1): loaded http://localhost:47309/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:47309/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:20:48 INFO - PID 8847 | RSS: Main: 182628352 22:20:48 INFO - PID 8847 | 22:20:51 INFO - PID 8847 | Cycle 1(1): loaded http://localhost:47309/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:47309/tests/kraken/driver.html?testName=imaging-darkroom) 22:20:52 INFO - PID 8847 | RSS: Main: 183500800 22:20:52 INFO - PID 8847 | 22:20:55 INFO - PID 8847 | Cycle 1(1): loaded http://localhost:47309/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:47309/tests/kraken/driver.html?testName=imaging-desaturate) 22:20:56 INFO - PID 8847 | RSS: Main: 182566912 22:20:56 INFO - PID 8847 | 22:20:59 INFO - PID 8847 | Cycle 1(1): loaded http://localhost:47309/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:47309/tests/kraken/driver.html?testName=json-parse-financial) 22:20:59 INFO - PID 8847 | RSS: Main: 182919168 22:20:59 INFO - PID 8847 | 22:21:01 INFO - PID 8847 | Cycle 1(1): loaded http://localhost:47309/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:47309/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:21:02 INFO - PID 8847 | RSS: Main: 183283712 22:21:02 INFO - PID 8847 | 22:21:03 INFO - PID 8847 | Cycle 1(1): loaded http://localhost:47309/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:47309/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:21:04 INFO - PID 8847 | RSS: Main: 182939648 22:21:04 INFO - PID 8847 | 22:21:06 INFO - PID 8847 | Cycle 1(1): loaded http://localhost:47309/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:47309/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:21:07 INFO - PID 8847 | RSS: Main: 182906880 22:21:07 INFO - PID 8847 | 22:21:10 INFO - PID 8847 | Cycle 1(1): loaded http://localhost:47309/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:47309/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:21:11 INFO - PID 8847 | RSS: Main: 182964224 22:21:11 INFO - PID 8847 | 22:21:14 INFO - PID 8847 | Cycle 1(1): loaded http://localhost:47309/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:47309/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:21:14 INFO - PID 8847 | RSS: Main: 182714368 22:21:14 INFO - PID 8847 | 22:21:16 INFO - PID 8847 | Cycle 1(1): loaded http://localhost:47309/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:47309/tests/kraken/driver.html?testName=ai-astar) 22:21:16 INFO - PID 8847 | RSS: Main: 184180736 22:21:16 INFO - PID 8847 | 22:21:16 INFO - PID 8847 | __start_tp_report 22:21:16 INFO - PID 8847 | _x_x_mozilla_page_load 22:21:16 INFO - PID 8847 | _x_x_mozilla_page_load_details 22:21:16 INFO - PID 8847 | |i|pagename|runs| 22:21:16 INFO - PID 8847 | |0;ai-astar;103;112;111;110;111;112;110;111;113;114 22:21:16 INFO - PID 8847 | |1;audio-beat-detection;154;130;123;173;122;130;129;122;147;123 22:21:16 INFO - PID 8847 | |2;audio-dft;163;164;165;171;168;175;163;164;164;163 22:21:16 INFO - PID 8847 | |3;audio-fft;78;74;76;114;74;74;74;74;94;74 22:21:16 INFO - PID 8847 | |4;audio-oscillator;86;82;102;84;84;84;95;84;85;103 22:21:16 INFO - PID 8847 | |5;imaging-gaussian-blur;114;115;114;114;113;114;117;114;114;114 22:21:16 INFO - PID 8847 | |6;imaging-darkroom;149;151;152;151;150;151;150;151;149;150 22:21:16 INFO - PID 8847 | |7;imaging-desaturate;96;96;96;94;95;94;95;94;95;94 22:21:16 INFO - PID 8847 | |8;json-parse-financial;53;53;55;55;55;61;55;55;54;55 22:21:16 INFO - PID 8847 | |9;json-stringify-tinderbox;56;58;57;56;57;56;56;56;56;58 22:21:16 INFO - PID 8847 | |10;stanford-crypto-aes;88;87;88;94;89;86;96;89;121;87 22:21:16 INFO - PID 8847 | |11;stanford-crypto-ccm;136;133;132;138;132;131;136;138;140;144 22:21:16 INFO - PID 8847 | |12;stanford-crypto-pbkdf2;190;195;194;195;197;200;194;185;197;192 22:21:16 INFO - PID 8847 | |13;stanford-crypto-sha256-iterative;79;79;72;72;78;73;71;75;71;73 22:21:16 INFO - PID 8847 | __end_tp_report 22:21:16 INFO - PID 8847 | __start_cc_report 22:21:16 INFO - PID 8847 | _x_x_mozilla_cycle_collect,1036 22:21:16 INFO - PID 8847 | __end_cc_report 22:21:16 INFO - PID 8847 | __startTimestamp1495948876901__endTimestamp 22:21:16 INFO - PID 8847 | 22:21:16 INFO - PID 8847 | ------- Summary: start ------- 22:21:16 INFO - PID 8847 | Number of tests: 14 22:21:16 INFO - PID 8847 | 22:21:16 INFO - PID 8847 | [#0] ai-astar Cycles:10 Average:110.70 Median:111.50 stddev:2.98 (2.7%) stddev-sans-first:1.33 22:21:16 INFO - PID 8847 | Values: 103.0 112.0 111.0 110.0 111.0 112.0 110.0 111.0 113.0 114.0 22:21:16 INFO - PID 8847 | 22:21:16 INFO - PID 8847 | [#1] audio-beat-detection Cycles:10 Average:135.30 Median:130.00 stddev:17.19 (13.2%) stddev-sans-first:16.85 22:21:16 INFO - PID 8847 | Values: 154.0 130.0 123.0 173.0 122.0 130.0 129.0 122.0 147.0 123.0 22:21:16 INFO - PID 8847 | 22:21:16 INFO - PID 8847 | [#2] audio-dft Cycles:10 Average:166.00 Median:164.50 stddev:4.08 (2.5%) stddev-sans-first:4.18 22:21:16 INFO - PID 8847 | Values: 163.0 164.0 165.0 171.0 168.0 175.0 163.0 164.0 164.0 163.0 22:21:16 INFO - PID 8847 | 22:21:16 INFO - PID 8847 | [#3] audio-fft Cycles:10 Average:80.60 Median:74.00 stddev:13.27 (17.9%) stddev-sans-first:14.04 22:21:16 INFO - PID 8847 | Values: 78.0 74.0 76.0 114.0 74.0 74.0 74.0 74.0 94.0 74.0 22:21:16 INFO - PID 8847 | 22:21:16 INFO - PID 8847 | [#4] audio-oscillator Cycles:10 Average:88.90 Median:84.00 stddev:7.99 (9.5%) stddev-sans-first:8.41 22:21:16 INFO - PID 8847 | Values: 86.0 82.0 102.0 84.0 84.0 84.0 95.0 84.0 85.0 103.0 22:21:16 INFO - PID 8847 | 22:21:16 INFO - PID 8847 | [#5] imaging-gaussian-blur Cycles:10 Average:114.30 Median:114.00 stddev:1.06 (0.9%) stddev-sans-first:1.12 22:21:16 INFO - PID 8847 | Values: 114.0 115.0 114.0 114.0 113.0 114.0 117.0 114.0 114.0 114.0 22:21:16 INFO - PID 8847 | 22:21:16 INFO - PID 8847 | [#6] imaging-darkroom Cycles:10 Average:150.40 Median:151.00 stddev:0.97 (0.6%) stddev-sans-first:0.88 22:21:16 INFO - PID 8847 | Values: 149.0 151.0 152.0 151.0 150.0 151.0 150.0 151.0 149.0 150.0 22:21:16 INFO - PID 8847 | 22:21:16 INFO - PID 8847 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.88 (0.9%) stddev-sans-first:0.83 22:21:16 INFO - PID 8847 | Values: 96.0 96.0 96.0 94.0 95.0 94.0 95.0 94.0 95.0 94.0 22:21:16 INFO - PID 8847 | 22:21:16 INFO - PID 8847 | [#8] json-parse-financial Cycles:10 Average:55.10 Median:55.00 stddev:2.23 (4.1%) stddev-sans-first:2.24 22:21:16 INFO - PID 8847 | Values: 53.0 53.0 55.0 55.0 55.0 61.0 55.0 55.0 54.0 55.0 22:21:16 INFO - PID 8847 | 22:21:16 INFO - PID 8847 | [#9] json-stringify-tinderbox Cycles:10 Average:56.60 Median:56.50 stddev:0.84 (1.5%) stddev-sans-first:0.87 22:21:16 INFO - PID 8847 | Values: 56.0 58.0 57.0 56.0 57.0 56.0 56.0 56.0 56.0 58.0 22:21:16 INFO - PID 8847 | 22:21:16 INFO - PID 8847 | [#10] stanford-crypto-aes Cycles:10 Average:92.50 Median:88.50 stddev:10.51 (11.9%) stddev-sans-first:11.02 22:21:16 INFO - PID 8847 | Values: 88.0 87.0 88.0 94.0 89.0 86.0 96.0 89.0 121.0 87.0 22:21:16 INFO - PID 8847 | 22:21:16 INFO - PID 8847 | [#11] stanford-crypto-ccm Cycles:10 Average:136.00 Median:137.00 stddev:4.14 (3.0%) stddev-sans-first:4.39 22:21:16 INFO - PID 8847 | Values: 136.0 133.0 132.0 138.0 132.0 131.0 136.0 138.0 140.0 144.0 22:21:16 INFO - PID 8847 | 22:21:16 INFO - PID 8847 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:193.90 Median:195.00 stddev:4.18 (2.1%) stddev-sans-first:4.18 22:21:16 INFO - PID 8847 | Values: 190.0 195.0 194.0 195.0 197.0 200.0 194.0 185.0 197.0 192.0 22:21:16 INFO - PID 8847 | 22:21:16 INFO - PID 8847 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:74.30 Median:74.00 stddev:3.23 (4.4%) stddev-sans-first:2.95 22:21:16 INFO - PID 8847 | Values: 79.0 79.0 72.0 72.0 78.0 73.0 71.0 75.0 71.0 73.0 22:21:16 INFO - PID 8847 | -------- Summary: end -------- 22:21:16 INFO - PID 8847 | 22:21:18 INFO - TEST-INFO | 8847: exit 0 22:21:18 INFO - TEST-OK | kraken | took 93264ms 22:21:18 INFO - SUITE-END | took 1241s 22:21:18 INFO - Completed test suite (00:20:41) 22:21:18 INFO - javascript benchmark 22:21:18 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6830.396428567513, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2720.9727902720974, 2744.1218809980787, 2767.3081729567607, 2784.6240757497744, 2786.122371452991, 5237.5548078413285, 5360.383555891069, 5376.408595054546, 5422.566194704424, 5433.1035379162395, 5345.973270133653, 5350.946490535093, 5361.169018802082, 5447.782088716446, 5452.454754524546, 4519.186546421643, 4719.575238228559, 4776.211925032366, 4802.543758342952, 4809.831655892044, 4851.660383773137, 4893.902121957559, 4894.583960363373, 4911.5088491150955, 4914.3611330527165, 4675.18184317743, 4734.502877197913, 4736.0, 4820.132376172288, 4848.272759086165, 4810.037992401499, 4818.277258411232, 4838.540338667821, 4841.2496063110275, 4859.1739404301, 4761.904761904742, 4780.952190478086, 4787.952120478785, 4792.424909010906, 4792.856214313576, 5197.324347834795, 5372.194170874361, 5382.111951527993, 5396.703181325026, 5410.161424979135, 5738.598298119134, 5743.856403589902, 5864.091065884794, 5864.149698293723, 5871.8532036699, 5921.082232254007, 5922.3781502942, 5922.911156332659, 5926.4666180044005, 5964.463198312129, 5465.207544906006, 5465.289512363447, 5468.097763868917, 5470.589705772083, 5473.863153421196, 5861.648301101947, 5891.823245302648, 5931.970340148272, 5960.940390596125, 6037.54718396122, 5772.365039845614, 5774.364819869811, 5776.075827867521, 5794.797182098607, 5811.970940145272, 5612.382637909826, 5830.038043722739, 5849.970750146222, 5865.472107510259, 5866.6186697864505, 5589.636673616202, 5684.63049901755, 5797.594168408171, 5807.361190269067, 5814.418558144152, 5676.460736230051, 5685.914711279252, 5691.03252447085, 5770.451807078321, 5775.88448231033, 4861.465238823726, 4875.658703890694, 4880.755962201875, 4893.168161412568, 4921.360223170965, 4112.074783173822, 4149.170165966819, 4158.896027599334, 4202.915941681211, 4226.387173859835, 4702.623790096784, 4814.15752243356, 4817.229243321051, 4894.681845680019, 4927.063857866994, 5708.0, 5737.995850726106, 5788.218590490314, 5802.071668533099, 5808.767649294065, 4894.412670479494, 4902.975485122623, 4904.0, 4906.975465122651, 4934.777934992934, 5158.0, 5159.1487404578575, 5162.1224391853475, 5164.561012313995, 5215.087359712035, 5248.3701955765555, 5325.653832500875, 5329.57363410934, 5405.621606487665, 5412.269343638558, 5731.484166425042, 5825.41745825431, 5874.0, 5885.47030767233, 5886.323072846678, 5265.183896496049, 5337.706426146444, 5344.4121146674615, 5358.678479291255, 5366.812161574482, 5583.609147359646, 5719.428057194247, 5724.112762521816, 5727.02640551099, 5764.481196692318, 5692.345380281321, 5719.685417302088, 5774.393688662798, 5831.679257640871, 5891.941080589139, 5678.4605462480995, 5678.716064196857, 5682.545396368363, 5722.313322401338, 5734.0, 5682.659040457585, 5682.715864206856, 5686.061799802987, 5690.573207009574, 5691.2032315475035, 5421.972890135524, 5519.862003449946, 5531.695756733257, 5537.0, 5593.384727680033, 5621.100623900156, 5642.266505354278, 5709.400512946247, 5721.5136713379825, 5731.656100633975, 5507.9449205507435, 5513.889722205614, 5520.199571062254, 5539.14143307788, 5569.805056822992], "value": 5254.348177461778, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [666.7599664120916, 724.8079258996366, 746.7274444827638, 1089.3463921647012, 1102.167863263236, 31978.840105799467, 32585.837070814643, 32778.836105819464, 32780.67219327806, 32973.67026329736, 34114.48828267578, 34302.0, 34379.0, 34419.31161376777, 34547.481787773206, 6482.7406903723795, 6729.966350168254, 6756.223034351064, 6854.417374523172, 6869.0, 6717.764878229263, 6748.156480439945, 6748.561343512681, 6780.660966951657, 6831.180258368978, 6758.9324106758795, 6795.728170873159, 6824.931750682504, 6838.452923766112, 6856.451483881277, 6731.528792984493, 6731.5624484408845, 6747.325267473262, 6761.560498567577, 6810.387065164135, 6623.172103487064, 6665.6667166641955, 6697.162854643169, 6708.530402871801, 6710.396064354231, 31234.687653123405, 31538.842305788552, 31551.211219719462, 31576.052718418483, 31764.20589485258, 3073.477508823483, 3119.3605310911207, 3130.264387868849, 3138.5135304027913, 3138.8587513561943, 24276.271711848498, 24329.39176520601, 24331.513369732682, 24379.878100609385, 24395.14616988397, 2928.180109569324, 2931.428371467565, 2939.9853000735075, 2940.970590294091, 2947.2189869684553, 113070.0, 114270.0, 129853.0, 130508.0, 130530.0, 37563.24873502569, 37897.43153852639, 38390.616093839264, 38396.6160338393, 38402.80798596045, 39622.405663915066, 39978.40032399516, 40060.19879602391, 40129.0, 40278.0, 12505.437255323532, 12618.116731828868, 12665.176763510342, 12671.0, 12671.17637353569, 10254.461830725451, 10325.741856453498, 10355.326903751233, 10359.585616575252, 10377.429241391796, 12470.43883025266, 12558.686032849251, 12581.559645412366, 12584.37078146089, 12668.303243321705, 5325.201219817059, 5331.973340133274, 5332.200169974535, 5416.837494875082, 5448.591355648342, 860.3762272352494, 914.5381582301028, 916.6287653500343, 927.4667066436825, 935.373299889076, 20540.383788486368, 21287.68068478974, 21516.0, 21531.354059378245, 21760.673589896163, 987.8814542254831, 993.1607791416242, 1010.782681723433, 1017.2675673515057, 1018.7198520406799, 10904.34573925567, 11106.44467776608, 11198.104151667847, 11293.604723834791, 11329.37688427128, 169050.0, 170045.0, 170302.0, 170629.0, 171051.0, 40431.393529097084, 40648.39027414591, 40654.0, 40660.59339406627, 40671.0, 1210.3403645013489, 1256.2839181666363, 1258.534342293339, 1261.7224210673821, 1265.1649911058657, 19919.701204481655, 20382.18471261192, 20884.47788805231, 20926.0, 21253.46866328354, 28787.568186477638, 28869.27826804347, 31934.201644959063, 32420.75792420739, 32441.0, 149718.0, 150775.24612376868, 151119.0, 151697.0, 152501.0, 28845.711542884303, 29924.251893702833, 30042.3991520164, 30128.0, 30146.8750312443, 35023.29953400969, 35944.460833087, 36023.27953440969, 36586.0, 37228.25543489061, 27414.5887811679, 27497.45005099847, 27702.584461232695, 28140.01509947142, 28536.85731571329, 27410.72589274082, 27526.311842204104, 28237.717622823508, 28426.147215583565, 28888.711112888603, 30458.390832183675, 30806.845965770026, 30847.2288192797, 30867.38265234638, 30891.0, 25946.870265649308, 26214.60678089792, 26290.868545657915, 26708.46583068289, 27709.861450692617, 19716.802831971498, 22057.33827985163, 22394.552108958054, 22405.43986400353, 22504.88747556252], "value": 14345.18015014482, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [407.31164332278445, 407.6575676431797, 421.1240619511416, 433.49930829891485, 433.79611582556197, 17084.48746537604, 17881.105944702762, 17929.103544822756, 18166.27334906602, 18693.158807853644, 18553.628927421476, 18918.0, 19037.428877133672, 19170.0, 19171.32900348488, 5470.507654311111, 5544.972275138619, 5644.0, 5655.5475561954945, 5677.6373670319035, 5547.77808887644, 5605.131204663284, 5620.072688006474, 5620.606557540974, 5640.04119299718, 5091.0, 5336.733163341837, 5560.2493663355335, 5593.440655934414, 5599.720013999304, 5275.498827611371, 5275.86810329741, 5299.152135658314, 5326.387465441485, 5332.33345831771, 4677.812887484531, 4829.492903245144, 4833.637477189225, 4836.564709176191, 4854.053459575384, 21836.672449913265, 21917.671234931488, 22009.779902200935, 22164.88917555402, 22363.0, 1632.5510484616707, 1657.5938894970689, 1658.8009438867293, 1661.3852874436536, 1664.1097013098056, 14584.781228281585, 14610.707785844224, 15140.924295378563, 15241.771373429407, 15270.236488175658, 1956.1686283329527, 1989.801019898013, 2018.6265540874986, 2021.9696704549444, 2028.1988614497338, 89837.55081224552, 90424.5478772602, 90622.0, 91447.0, 92025.53987230088, 10694.223583219677, 10958.506867190836, 10979.231453798317, 10996.725081872857, 11277.928596783293, 14691.853081469262, 14723.043002204822, 14745.11529308245, 14808.555743327717, 14815.814734821404, 7328.853422931512, 7618.961905190438, 7748.690052397841, 7787.805304867424, 8061.4760040597175, 6893.586384816927, 6950.721971121199, 7029.929700702927, 7141.178764442052, 7171.713131474683, 6968.58188508681, 6992.6853291602, 7026.718931242795, 7051.471139664545, 7065.2228254891925, 1926.7687877454796, 1938.2440848069264, 1946.5717542140706, 1963.6956271777897, 2078.4803799050237, 833.8374017066614, 869.2524428991063, 887.3078998381272, 900.6307413960245, 906.9183773460288, 16874.409395671093, 17030.659386812193, 17160.313587456363, 17333.653326933392, 17832.375866844857, 873.3973558244791, 878.6748902905838, 879.6965047058754, 888.5424006636588, 907.2605826251583, 9344.766380840398, 11061.281016733887, 11989.0, 12051.75896482083, 12185.45165467556, 370448.0, 372739.0, 374829.0, 378808.0, 386201.0, 78111.0, 78192.0, 78503.60748196336, 79134.0, 81900.0, 1036.7978244242452, 1042.744527590745, 1075.3547871277171, 1078.7626722121122, 1088.0479580367178, 17490.775645704678, 17501.0, 18119.456416307006, 18571.628567428306, 18828.0, 38699.0, 38909.6109038906, 39124.80437597794, 39569.60430395659, 39667.603323967545, 49189.508104918496, 49536.75231623819, 50914.74542627263, 51961.48038519567, 52518.0, 7898.091719452336, 8212.3430125591, 8308.127646597262, 8476.237138657303, 8499.660013599387, 11064.446777661246, 12634.936825315815, 12817.295048772407, 12877.871221287667, 13439.932800336326, 10114.241431892784, 10654.73363165927, 10874.184436167478, 11369.0, 11906.464209110783, 10658.573657053632, 10721.946390268311, 10857.40284284372, 10873.510692018719, 10924.617638382937, 10739.838902416313, 10847.349159050482, 11055.391953442639, 11205.66383008511, 11444.82832757526, 8163.918360816316, 8210.753677389688, 8234.711785087493, 8237.217464340878, 8291.792705182419, 10541.0, 10602.89397106019, 11183.776324473301, 11520.94239528797, 11541.192116551762], "value": 8921.416060654317, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1252.94988200472, 1318.749437606854, 1320.4190156331213, 1324.9933750331247, 1336.7326534693061, 10309.793804123923, 10728.946355268232, 10790.622328218515, 10804.891951080486, 11074.944625276883, 10857.45712714365, 11094.889051109487, 11105.944470277638, 11138.721531961684, 11163.162762792783, 2110.7572629147653, 2153.5908177446313, 2167.794059564339, 2171.5873983943, 2172.174573662014, 2171.576542574199, 2207.1833421633937, 2210.06072419222, 2212.4358288636454, 2218.9889050554725, 2144.485323522359, 2177.8693278403266, 2180.1824315881545, 2184.464806122502, 2204.9967264894512, 2124.129107066103, 2124.3945475539476, 2138.219549864304, 2141.967870481944, 2152.4726442021806, 1851.879627824187, 1912.6270377276437, 1941.2526177421653, 1963.6072785442825, 1970.270999730109, 10336.224783141295, 10677.092447142002, 10688.625898093529, 10701.09040731531, 10704.839427408595, 5696.772129114872, 5941.287045554518, 5941.910871336933, 5961.046232602763, 5962.612430192024, 3283.277678910636, 3380.4760262159402, 3390.3727810355163, 3455.6198818129988, 3474.774139680913, 1098.741795678015, 1116.8492253545749, 1132.224426268009, 1138.7893239750672, 1159.9884001159965, 15140.242987850563, 15270.0, 15282.083075015535, 15285.770713439308, 15299.847001529954, 4745.976270118696, 4874.439439464436, 4986.576141028053, 5006.774695138727, 5019.196928491424, 11064.944675276573, 11088.22382433238, 11096.889031109748, 11133.498992545356, 11160.609378671708, 5523.640963337451, 5662.915056274159, 5709.54323654115, 5723.627964182315, 5725.484706376446, 5183.714895680699, 5248.239005344204, 5264.0259902536545, 5270.288511050959, 5320.414754377015, 3795.69634429245, 3803.2963901678277, 3856.5757766645647, 3957.426173204869, 3964.7819369934355, 1151.1136424952906, 1152.8040233160382, 1154.3593305715408, 1160.9535618575162, 1174.3188950408742, 676.5940435738518, 703.7325816189917, 709.2942522190453, 723.4754802768057, 728.7595093619093, 5294.788208471618, 5347.1979203119845, 5407.134858422633, 5467.152591348347, 5504.284443022381, 535.7642637239602, 536.2840607788646, 547.7671989404487, 548.5501888451431, 549.8982688202695, 3428.8457019434186, 3429.8852872816433, 3471.7743346682387, 3481.112316359312, 3593.766405183707, 13932.791008134885, 14186.85813141876, 14508.202048887413, 14512.274386280644, 14516.637084072983, 14132.505362312475, 14387.064840785315, 14506.709865802624, 14510.419583216553, 14516.782248266285, 7285.777837759429, 7558.622068896533, 7778.22217778229, 7836.098848632366, 7852.450328477066, 5707.343655479507, 5957.3744756799915, 6067.605605635619, 6151.6001459904965, 6338.176037115146, 12375.504979800708, 12680.492780289054, 12730.872691272969, 12891.48434062627, 12915.935420322838, 13071.411786469822, 13143.474261029452, 13158.14472059313, 13185.80221296662, 13405.396757145756, 9137.40606860552, 9490.240780737662, 9627.807443850943, 9681.70954871355, 9683.370580912218, 10044.447555384524, 10210.38737675712, 10223.233257505866, 10229.84655230187, 10240.129588984722, 8343.0, 8356.415050946376, 8440.282575981111, 8829.072947340694, 8864.0, 7522.172561018393, 7592.088949326117, 8046.235607617267, 8142.47073940192, 8312.709055183039, 7307.853842923006, 7396.55620662762, 7463.962680186564, 7636.045494313211, 7729.227077292226, 4842.709437433765, 5220.817271395635, 5289.285946397187, 5433.347998240237, 5528.308961379827, 5362.490563396471, 5411.242426060276, 5422.213779002102, 5487.506124448819, 5489.231507589021], "value": 4783.097448405515, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [374.8744170702814, 384.42912275271215, 392.53876694883525, 394.02871920715467, 400.67545288316467, 5412.161115027177, 5527.2538207341995, 5544.6673199608, 5563.527100196483, 5609.49514543691, 5330.440303768107, 5467.926394835843, 5470.042742520063, 5484.7933454639915, 5499.862503437416, 4316.6978311518205, 4323.805428755698, 4335.089631177457, 4338.84814031509, 4357.17213729392, 4234.6823988201, 4346.8913277168, 4354.564543545636, 4360.585744354281, 4366.694331396803, 4347.760873151976, 4353.434053573031, 4353.782310884459, 4358.629516491086, 4374.278244089722, 4333.393324934512, 4333.60997510224, 4336.392904993272, 4337.891552711176, 4346.826126954918, 3914.178022615254, 3957.7823219722904, 3962.0, 3977.9204415911518, 3982.880513584597, 5396.217548455491, 5407.242985981966, 5407.594430417695, 5425.864353391157, 5435.130379139358, 5093.821716239914, 5130.692158470503, 5137.434882162959, 5142.074426603247, 5175.948240517622, 5655.660660360391, 5829.571754920072, 5836.418411546958, 5837.664934026381, 5869.647821130746, 4419.734815911055, 4420.093880754438, 4428.095918754934, 4445.11097780442, 4450.1767173073085, 5907.556933229982, 5988.352928249596, 6051.515878729691, 6178.887800195963, 6230.501559875199, 4541.863744087683, 4569.948911750316, 4575.153596584576, 4575.954240457553, 4583.427071616048, 4639.489656137822, 4675.602573781199, 4676.18166820805, 4682.1338052460405, 4700.083483720641, 5001.349554646958, 5118.87202819925, 5123.205903085028, 5150.716710580879, 5151.742412879341, 5832.795852145155, 5840.2115714378015, 5856.443637854397, 5867.20792692981, 5879.676617786063, 1561.1725785333792, 1561.461295852929, 1574.9291281892342, 1577.846239882552, 1590.658008528172, 1125.8874112588676, 1164.6389619218069, 1169.5497233565138, 1170.5785917069848, 1176.335370515656, 4958.479359667183, 4967.82612608557, 4976.651634385558, 4981.90036199274, 4996.500349964975, 5938.524918006549, 5940.405959404025, 5946.881062378815, 5948.524118070544, 5969.253843269591, 4812.494688057704, 4961.7519124044375, 4983.8504844854715, 4989.925151122736, 4992.450830408652, 3154.3848949455096, 3168.6672899345235, 3172.5558421820965, 3177.459831828595, 3180.681931806847, 5433.782648694087, 5534.833954981357, 5552.444755524415, 5553.750081246273, 5564.777408903598, 6152.938470615237, 6155.538334624921, 6174.5060395168275, 6179.351168127372, 6191.628502289877, 5505.697186654773, 5514.476124768141, 5518.034343989866, 5537.252470916455, 5560.332760068737, 5782.85542861415, 5933.940660593339, 5979.551533634908, 6001.4298641628975, 6008.1588577598295, 5633.690147041952, 5874.148248503858, 5896.9115463268945, 5901.970490147522, 5938.673372964356, 5356.464353564613, 5430.674159550282, 5495.450454954473, 5511.421300763523, 5527.640703354269, 4154.7951094182345, 4166.604172603597, 4168.374743788456, 4173.2905406081645, 4182.64447521964, 5866.354700982974, 5879.5002424792665, 6032.276126864805, 6045.21412216409, 6072.817815465543, 5764.798232061858, 5787.652740835563, 5802.274715660543, 5804.8970695567705, 5831.970840145942, 5723.5707321950185, 5768.423157684198, 5785.334686511105, 5792.53659707214, 5815.0, 5665.603407761582, 5724.74238659253, 5730.71346432685, 5745.770169193353, 5757.596968212185, 5804.6807425590305, 5817.360090389969, 5841.386654401226, 5898.1152827076285, 5902.350741418355, 5418.187271909245, 5547.7780888764, 5565.220869078251, 5596.384397716167, 5693.28833895763], "value": 4448.7894953914565, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [741.2994719989605, 752.8343764371838, 768.55039801716, 769.7036640893258, 778.2023425988359, 11909.583164589241, 12447.439865206064, 13594.320283985799, 14703.779443308345, 14745.705085898275, 15469.84530154698, 15983.120928348937, 16010.5997350066, 16076.115813630246, 16091.0, 882.6513527156769, 897.8832751742265, 900.0729248873671, 900.0819164452255, 901.6078006067381, 906.7869050773063, 911.3939230411768, 912.1015799437548, 912.1835956818643, 918.7197904639082, 943.5989704375613, 950.6197520991624, 950.9667161649344, 951.281782254397, 951.6526467839224, 942.5946842857569, 945.1871390604075, 945.4091193004373, 948.9335746497748, 950.2255661635745, 691.325957191739, 692.7332976803967, 693.6462404173857, 697.1251079894699, 701.5790525684548, 13713.314334283346, 14056.508022219174, 14092.0, 14135.575932722035, 14313.928430357782, 14967.550973470814, 15647.608809779733, 15750.0, 15820.604484887856, 15832.525024249291, 11703.53185872564, 11802.940985295105, 11954.0, 11968.162228643998, 12031.578894738643, 2902.6661933877454, 2955.0543825975697, 2956.63042119735, 2958.319586495118, 2960.5263157894847, 71042.0, 71315.64342178256, 71547.28452715458, 71966.0, 78450.60774696147, 12155.574554890536, 12629.936850315873, 12667.683307917376, 12733.36333183337, 12977.221366717838, 21839.78160218409, 22081.227157049427, 22246.332610021724, 22248.221312254318, 23293.53412931732, 6003.189569408161, 6103.84740381494, 6130.938690613126, 6135.631862088199, 6148.1699970503405, 2968.732814046746, 3039.7416219621136, 3050.3136794221123, 3061.0969763919697, 3075.1543325585644, 3590.0665826885197, 3592.2815436912724, 3668.614795446493, 3674.889753307405, 3696.2792255510453, 651.9837004074936, 659.5482094765101, 669.1067424987599, 688.0539258519535, 764.1059959846992, 536.1823219590157, 550.9862253443616, 561.91290349995, 577.5721095299411, 585.783260193731, 9540.95229523848, 10073.848892266622, 10280.691579252634, 10280.742981425525, 10344.689659310232, 585.9209006784115, 586.2378907420336, 616.556079622671, 624.6345887655682, 644.5069521815815, 4216.915661686749, 4414.271645178574, 4435.933460998088, 4447.866564003085, 4543.522930092358, 80556.59721701354, 81017.0, 81662.59168704237, 84693.57653211695, 84884.0, 73400.26599734041, 75111.62444187744, 75409.0, 76556.0, 76732.0, 61813.0, 62438.375616243255, 66391.66804165948, 67414.32585674178, 68032.0, 8496.277816385676, 8986.101389860962, 8997.730068097968, 9057.547122643973, 9246.95376523113, 26480.470390592465, 26834.59748103741, 27160.72839271582, 27929.301767455978, 27933.86033069903, 48414.75792621014, 49104.143337067326, 49107.0, 49610.25584616306, 50435.74782126066, 15134.167620780963, 15361.539153825403, 15493.070415774639, 15610.721748432956, 15673.451429200379, 15962.28169732388, 16098.839011609734, 16139.515814525583, 16291.674166516841, 16459.25933332979, 11654.475548600163, 15012.549623511311, 15049.924750376178, 15170.924145379202, 15452.0, 14104.717905641624, 14107.083039602392, 14163.291835407983, 14281.64295892611, 14285.142891426547, 15452.613684657974, 15464.84535154679, 15900.76148857745, 16131.596710082342, 16447.0954097521, 9889.357191782512, 10061.144802691853, 10241.129503992244, 10346.275760696679, 10443.164546836388, 10731.40977246259, 11018.834717479405, 11358.26171298863, 11474.196806223485, 11503.942480287546], "value": 7096.365988958758, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1549.5, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 112.0, 111.0, 110.0, 111.0, 112.0, 110.0, 111.0, 113.0, 114.0], "value": 110.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 130.0, 123.0, 173.0, 122.0, 130.0, 129.0, 122.0, 147.0, 123.0], "value": 135.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 164.0, 165.0, 171.0, 168.0, 175.0, 163.0, 164.0, 164.0, 163.0], "value": 166.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 74.0, 76.0, 114.0, 74.0, 74.0, 74.0, 74.0, 94.0, 74.0], "value": 80.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 82.0, 102.0, 84.0, 84.0, 84.0, 95.0, 84.0, 85.0, 103.0], "value": 88.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 115.0, 114.0, 114.0, 113.0, 114.0, 117.0, 114.0, 114.0, 114.0], "value": 114.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 151.0, 152.0, 151.0, 150.0, 151.0, 150.0, 151.0, 149.0, 150.0], "value": 150.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 96.0, 94.0, 95.0, 94.0, 95.0, 94.0, 95.0, 94.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 53.0, 55.0, 55.0, 55.0, 61.0, 55.0, 55.0, 54.0, 55.0], "value": 55.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 58.0, 57.0, 56.0, 57.0, 56.0, 56.0, 56.0, 56.0, 58.0], "value": 56.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 87.0, 88.0, 94.0, 89.0, 86.0, 96.0, 89.0, 121.0, 87.0], "value": 92.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 133.0, 132.0, 138.0, 132.0, 131.0, 136.0, 138.0, 140.0, 144.0], "value": 136.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [190.0, 195.0, 194.0, 195.0, 197.0, 200.0, 194.0, 185.0, 197.0, 192.0], "value": 193.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 79.0, 72.0, 72.0, 78.0, 73.0, 71.0, 75.0, 71.0, 73.0], "value": 74.3, "unit": "score"}]}]} 22:21:18 INFO - Return code: 0 22:21:18 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 22:21:18 INFO - # TBPL SUCCESS # 22:21:18 INFO - Running post-action listener: _resource_record_post_action 22:21:18 INFO - [mozharness: 2017-05-28 05:21:18.734484Z] Finished run-tests step (success) 22:21:18 INFO - Running post-run listener: _resource_record_post_run 22:21:18 INFO - Total resource usage - Wall time: 1258s; CPU: 13.0%; Read bytes: 208896; Write bytes: 412680192; Read time: 504; Write time: 364220 22:21:18 INFO - TinderboxPrint: CPU usage
12.7% 22:21:18 INFO - TinderboxPrint: I/O read bytes / time
208,896 / 504 22:21:18 INFO - TinderboxPrint: I/O write bytes / time
412,680,192 / 364,220 22:21:18 INFO - TinderboxPrint: CPU idle
8,767.3 (87.3%) 22:21:18 INFO - TinderboxPrint: CPU user
1,218.4 (12.1%) 22:21:18 INFO - TinderboxPrint: Swap in / out
0 / 0 22:21:18 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 4096; Write bytes: 108552192; Read time: 44; Write time: 151860 22:21:18 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 22:21:18 INFO - run-tests - Wall time: 1242s; CPU: 13.0%; Read bytes: 204800; Write bytes: 304128000; Read time: 460; Write time: 212360 22:21:19 INFO - Running post-run listener: _upload_blobber_files 22:21:19 INFO - Blob upload gear active. 22:21:19 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 22:21:19 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 22:21:19 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-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 22:21:19 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-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 22:21:19 INFO - (blobuploader) - INFO - Open directory for files ... 22:21:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 22:21:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:21:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:21:20 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 22:21:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:21:20 INFO - (blobuploader) - INFO - Done attempting. 22:21:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 22:21:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:21:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:21:26 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 22:21:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:21:26 INFO - (blobuploader) - INFO - Done attempting. 22:21:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 22:21:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:21:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:21:27 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 22:21:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:21:27 INFO - (blobuploader) - INFO - Done attempting. 22:21:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 22:21:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:21:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:21:28 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 22:21:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:21:28 INFO - (blobuploader) - INFO - Done attempting. 22:21:28 INFO - (blobuploader) - INFO - Iteration through files over. 22:21:28 INFO - Return code: 0 22:21:28 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 22:21:28 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 22:21:28 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/10ec72b6146ef843bb6f653e9fe7137d03d8db352a846ea29e69ba08ca7afac1ce2a2af208338beeea1c0a2e03583841b95b1fb3bfd0737f8f35f64d38972cae", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/30eea5ddb0efd1889585fdd1d943cfbae1360165c4bdaadd7a8871e8b3d6d99120e7a14e3d63e3922bc91438ca7fb57e059a5f309bd56c8ef31e0f2aa051a9e7", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f29cf0a562ea23b5e8a8f119a8916a20cf6393a137787dc9875e8efaaf293c641e9ecf94f2d67ddd29fd9e10b3aa0650b69a6bac88e4ff94343073651b129992", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ca32acf1cd47f68ad9cca7e01c849e451d2477f9150e5d76795ddab25a6c145897cfde6c41df2f5cde08e628b7fc00b6abfe19929005781bd14ab042eb283dc3"} 22:21:28 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 22:21:28 INFO - Writing to file /builds/slave/test/properties/blobber_files 22:21:28 INFO - Contents: 22:21:28 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/10ec72b6146ef843bb6f653e9fe7137d03d8db352a846ea29e69ba08ca7afac1ce2a2af208338beeea1c0a2e03583841b95b1fb3bfd0737f8f35f64d38972cae", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/30eea5ddb0efd1889585fdd1d943cfbae1360165c4bdaadd7a8871e8b3d6d99120e7a14e3d63e3922bc91438ca7fb57e059a5f309bd56c8ef31e0f2aa051a9e7", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f29cf0a562ea23b5e8a8f119a8916a20cf6393a137787dc9875e8efaaf293c641e9ecf94f2d67ddd29fd9e10b3aa0650b69a6bac88e4ff94343073651b129992", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ca32acf1cd47f68ad9cca7e01c849e451d2477f9150e5d76795ddab25a6c145897cfde6c41df2f5cde08e628b7fc00b6abfe19929005781bd14ab042eb283dc3"} 22:21:28 INFO - Running post-run listener: copy_logs_to_upload_dir 22:21:28 INFO - Copying logs to upload dir... 22:21:28 INFO - mkdir: /builds/slave/test/build/upload/logs 22:21:28 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1320.457732 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 0 secs) (at 2017-05-27 22:21:28.377226) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-27 22:21:28.381179) ========= 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=745a4373a2a16df560f216e000000264-1495944412.112491-529162384 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-Non-PGO/sha512/10ec72b6146ef843bb6f653e9fe7137d03d8db352a846ea29e69ba08ca7afac1ce2a2af208338beeea1c0a2e03583841b95b1fb3bfd0737f8f35f64d38972cae", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/30eea5ddb0efd1889585fdd1d943cfbae1360165c4bdaadd7a8871e8b3d6d99120e7a14e3d63e3922bc91438ca7fb57e059a5f309bd56c8ef31e0f2aa051a9e7", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f29cf0a562ea23b5e8a8f119a8916a20cf6393a137787dc9875e8efaaf293c641e9ecf94f2d67ddd29fd9e10b3aa0650b69a6bac88e4ff94343073651b129992", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ca32acf1cd47f68ad9cca7e01c849e451d2477f9150e5d76795ddab25a6c145897cfde6c41df2f5cde08e628b7fc00b6abfe19929005781bd14ab042eb283dc3"} build_url:https://queue.taskcluster.net/v1/task/R8Wmzd1jQ_-NCuyrMuTTjA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011373 build_url: 'https://queue.taskcluster.net/v1/task/R8Wmzd1jQ_-NCuyrMuTTjA/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/10ec72b6146ef843bb6f653e9fe7137d03d8db352a846ea29e69ba08ca7afac1ce2a2af208338beeea1c0a2e03583841b95b1fb3bfd0737f8f35f64d38972cae", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/30eea5ddb0efd1889585fdd1d943cfbae1360165c4bdaadd7a8871e8b3d6d99120e7a14e3d63e3922bc91438ca7fb57e059a5f309bd56c8ef31e0f2aa051a9e7", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f29cf0a562ea23b5e8a8f119a8916a20cf6393a137787dc9875e8efaaf293c641e9ecf94f2d67ddd29fd9e10b3aa0650b69a6bac88e4ff94343073651b129992", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ca32acf1cd47f68ad9cca7e01c849e451d2477f9150e5d76795ddab25a6c145897cfde6c41df2f5cde08e628b7fc00b6abfe19929005781bd14ab042eb283dc3"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-27 22:21:28.411643) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-27 22:21:28.412169) ========= 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=745a4373a2a16df560f216e000000264-1495944412.112491-529162384 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004502 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-27 22:21:28.496489) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-27 22:21:28.496806) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-27 22:21:28.497114) ========= ========= Total master_lag: 0.18 =========