builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-012 starttime: 1496838797.38 results: success (0) revision: fb40bcb6155bd1e3ac5468ff4575cce171efbc12 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-06-07 05:33:17.380734) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-06-07 05:33:17.381213) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-06-07 05:33:17.381506) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-06-07 05:33:17.397480) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-06-07 05:33:17.397824) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1496838637.702639-1298006711 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-06-07 05:33:17-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 227M=0s 2017-06-07 05:33:17 (227 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.116719 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-06-07 05:33:17.527738) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-06-07 05:33:17.528024) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1496838637.702639-1298006711 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020334 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-06-07 05:33:17.577420) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-06-07 05:33:17.577717) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev fb40bcb6155bd1e3ac5468ff4575cce171efbc12 --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 fb40bcb6155bd1e3ac5468ff4575cce171efbc12 --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=2c5dd2b0a310ecf02fd87158000001b4-1496838637.702639-1298006711 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-06-07 05:33:18,058 truncating revision to first 12 chars 2017-06-07 05:33:18,058 Setting DEBUG logging. 2017-06-07 05:33:18,058 attempt 1/10 2017-06-07 05:33:18,058 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/fb40bcb6155b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-06-07 05:33:18,348 unpacking tar archive at: mozilla-central-fb40bcb6155b/testing/mozharness/ program finished with exit code 0 elapsedTime=0.970320 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-06-07 05:33:18.560303) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-06-07 05:33:18.560691) ========= script_repo_revision: fb40bcb6155bd1e3ac5468ff4575cce171efbc12 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-06-07 05:33:18.561122) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-06-07 05:33:18.561429) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-06-07 05:33:18.569989) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 47 secs) (at 2017-06-07 05:33:18.570278) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=2c5dd2b0a310ecf02fd87158000001b4-1496838637.702639-1298006711 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:33:19 INFO - MultiFileLogger online at 20170607 05:33:19 in /builds/slave/test 05:33:19 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 05:33:19 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:33:19 INFO - {'append_to_log': False, 05:33:19 INFO - 'base_work_dir': '/builds/slave/test', 05:33:19 INFO - 'blob_upload_branch': 'Firefox', 05:33:19 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:33:19 INFO - 'branch': 'Firefox', 05:33:19 INFO - 'buildbot_json_path': 'buildprops.json', 05:33:19 INFO - 'config_files': ('talos/linux_config.py',), 05:33:19 INFO - 'default_actions': ('clobber', 05:33:19 INFO - 'read-buildbot-config', 05:33:19 INFO - 'download-and-extract', 05:33:19 INFO - 'populate-webroot', 05:33:19 INFO - 'create-virtualenv', 05:33:19 INFO - 'install', 05:33:19 INFO - 'setup-mitmproxy', 05:33:19 INFO - 'run-tests'), 05:33:19 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:33:19 INFO - 'download_minidump_stackwalk': True, 05:33:19 INFO - 'download_symbols': 'ondemand', 05:33:19 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:33:19 INFO - 'tooltool.py': '/tools/tooltool.py', 05:33:19 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:33:19 INFO - '/tools/misc-python/virtualenv.py')}, 05:33:19 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:33:19 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:33:19 INFO - 'gecko_profile': False, 05:33:19 INFO - 'gecko_profile_interval': 0, 05:33:19 INFO - 'installer_path': 'installer.exe', 05:33:19 INFO - 'log_level': 'info', 05:33:19 INFO - 'log_name': 'talos', 05:33:19 INFO - 'log_to_console': True, 05:33:19 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:33:19 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:33:19 INFO - 'opt_config_files': (), 05:33:19 INFO - 'pip_index': False, 05:33:19 INFO - 'suite': 'dromaeojs-e10s', 05:33:19 INFO - 'system_bits': '32', 05:33:19 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:33:19 INFO - 'title': 'talos-linux64-ix-012', 05:33:19 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:33:19 INFO - 'use_talos_json': True, 05:33:19 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:33:19 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:33:19 INFO - 'work_dir': 'build'} 05:33:19 INFO - [mozharness: 2017-06-07 12:33:19.151979Z] Running clobber step. 05:33:19 INFO - Running pre-action listener: _resource_record_pre_action 05:33:19 INFO - Running main action method: clobber 05:33:19 INFO - rmtree: /builds/slave/test/build 05:33:19 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:33:20 INFO - Running post-action listener: _resource_record_post_action 05:33:20 INFO - [mozharness: 2017-06-07 12:33:20.173299Z] Finished clobber step (success) 05:33:20 INFO - [mozharness: 2017-06-07 12:33:20.173401Z] Running read-buildbot-config step. 05:33:20 INFO - Running pre-action listener: _resource_record_pre_action 05:33:20 INFO - Running main action method: read_buildbot_config 05:33:20 INFO - Using buildbot properties: 05:33:20 INFO - { 05:33:20 INFO - "project": "", 05:33:20 INFO - "product": "firefox", 05:33:20 INFO - "who": "cbook@mozilla.com", 05:33:20 INFO - "installer_path": "public/build/target.tar.bz2", 05:33:20 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 05:33:20 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 05:33:20 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 05:33:20 INFO - "stage_platform": "linux64-pgo", 05:33:20 INFO - "basedir": "/builds/slave/test", 05:33:20 INFO - "buildnumber": 0, 05:33:20 INFO - "platform": "ubuntu64_hw", 05:33:20 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 05:33:20 INFO - "slavebuilddir": "test", 05:33:20 INFO - "taskId": "czO8kI0sQY2xKt8j3RSivA", 05:33:20 INFO - "branch": "mozilla-central", 05:33:20 INFO - "script_repo_revision": "production", 05:33:20 INFO - "revision": "fb40bcb6155bd1e3ac5468ff4575cce171efbc12", 05:33:20 INFO - "slavename": "talos-linux64-ix-012", 05:33:20 INFO - "repo_path": "mozilla-central" 05:33:20 INFO - } 05:33:20 INFO - Finding installer, test and symbols from parent task. 05:33:20 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/czO8kI0sQY2xKt8j3RSivA'}, attempt #1 05:33:20 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/czO8kI0sQY2xKt8j3RSivA'}, attempt #1 05:33:21 INFO - Task dependencies: H4Wo3ZRMQ7iGiSIB2eANQw 05:33:21 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/H4Wo3ZRMQ7iGiSIB2eANQw'}, attempt #1 05:33:21 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/H4Wo3ZRMQ7iGiSIB2eANQw/artifacts/public/build/target.tar.bz2 05:33:21 INFO - Set test_url: https://queue.taskcluster.net/v1/task/H4Wo3ZRMQ7iGiSIB2eANQw/artifacts/public/build/test_packages.json 05:33:21 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/H4Wo3ZRMQ7iGiSIB2eANQw/artifacts/public/build/target.crashreporter-symbols.zip 05:33:21 INFO - Running post-action listener: _resource_record_post_action 05:33:21 INFO - [mozharness: 2017-06-07 12:33:21.507834Z] Finished read-buildbot-config step (success) 05:33:21 INFO - [mozharness: 2017-06-07 12:33:21.508054Z] Running download-and-extract step. 05:33:21 INFO - Running pre-action listener: _resource_record_pre_action 05:33:21 INFO - Running main action method: download_and_extract 05:33:21 INFO - mkdir: /builds/slave/test/build/tests 05:33:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:33:21 INFO - trying https://queue.taskcluster.net/v1/task/H4Wo3ZRMQ7iGiSIB2eANQw/artifacts/public/build/target.test_packages.json 05:33:21 INFO - Downloading https://queue.taskcluster.net/v1/task/H4Wo3ZRMQ7iGiSIB2eANQw/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 05:33:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/H4Wo3ZRMQ7iGiSIB2eANQw/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 05:33:22 INFO - Downloaded 989 bytes. 05:33:22 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 05:33:22 INFO - Using the following test package requirements: 05:33:22 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 05:33:22 INFO - u'common': [u'target.common.tests.zip'], 05:33:22 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 05:33:22 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 05:33:22 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 05:33:22 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 05:33:22 INFO - u'mozbase': [u'target.common.tests.zip'], 05:33:22 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 05:33:22 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 05:33:22 INFO - u'web-platform': [u'target.common.tests.zip', 05:33:22 INFO - u'target.web-platform.tests.tar.gz'], 05:33:22 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 05:33:22 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 05:33:22 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/H4Wo3ZRMQ7iGiSIB2eANQw/artifacts/public/build/target.common.tests.zip 05:33:22 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/H4Wo3ZRMQ7iGiSIB2eANQw/artifacts/public/build/target.common.tests.zip'}, attempt #1 05:33:22 INFO - Fetch https://queue.taskcluster.net/v1/task/H4Wo3ZRMQ7iGiSIB2eANQw/artifacts/public/build/target.common.tests.zip into memory 05:33:23 INFO - Content-Length response header: 65734037 05:33:23 INFO - Bytes received: 65734037 05:33:34 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 05:33:34 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/H4Wo3ZRMQ7iGiSIB2eANQw/artifacts/public/build/target.common.tests.zip 05:33:34 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/H4Wo3ZRMQ7iGiSIB2eANQw/artifacts/public/build/target.common.tests.zip'}, attempt #1 05:33:34 INFO - Fetch https://queue.taskcluster.net/v1/task/H4Wo3ZRMQ7iGiSIB2eANQw/artifacts/public/build/target.common.tests.zip into memory 05:33:35 INFO - Content-Length response header: 65734037 05:33:35 INFO - Bytes received: 65734037 05:33:46 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/H4Wo3ZRMQ7iGiSIB2eANQw/artifacts/public/build/target.talos.tests.zip 05:33:46 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/H4Wo3ZRMQ7iGiSIB2eANQw/artifacts/public/build/target.talos.tests.zip'}, attempt #1 05:33:46 INFO - Fetch https://queue.taskcluster.net/v1/task/H4Wo3ZRMQ7iGiSIB2eANQw/artifacts/public/build/target.talos.tests.zip into memory 05:33:47 INFO - Content-Length response header: 14447563 05:33:47 INFO - Bytes received: 14447563 05:33:47 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')]} 05:33:47 INFO - trying https://queue.taskcluster.net/v1/task/H4Wo3ZRMQ7iGiSIB2eANQw/artifacts/public/build/target.tar.bz2 05:33:47 INFO - Downloading https://queue.taskcluster.net/v1/task/H4Wo3ZRMQ7iGiSIB2eANQw/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 05:33:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/H4Wo3ZRMQ7iGiSIB2eANQw/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 05:33:49 INFO - Downloaded 59741792 bytes. 05:33:49 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/H4Wo3ZRMQ7iGiSIB2eANQw/artifacts/public/build/target.tar.bz2 05:33:49 INFO - mkdir: /builds/slave/test/properties 05:33:49 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:33:49 INFO - Writing to file /builds/slave/test/properties/build_url 05:33:49 INFO - Contents: 05:33:49 INFO - build_url:https://queue.taskcluster.net/v1/task/H4Wo3ZRMQ7iGiSIB2eANQw/artifacts/public/build/target.tar.bz2 05:33:49 INFO - Running post-action listener: _resource_record_post_action 05:33:49 INFO - Running post-action listener: set_extra_try_arguments 05:33:49 INFO - [mozharness: 2017-06-07 12:33:49.200208Z] Finished download-and-extract step (success) 05:33:49 INFO - [mozharness: 2017-06-07 12:33:49.200305Z] Running populate-webroot step. 05:33:49 INFO - Running pre-action listener: _resource_record_pre_action 05:33:49 INFO - Running main action method: populate_webroot 05:33:49 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:33:49 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:33:49 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:33:49 INFO - '--tppagecycles', 05:33:49 INFO - '7'], 05:33:49 INFO - 'tests': ['tsvgm']}}, 05:33:49 INFO - 'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:33:49 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:33:49 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:33:49 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:33:49 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 05:33:49 INFO - 'talos_options': ['--disable-e10s'], 05:33:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:33:49 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 05:33:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:33:49 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 05:33:49 INFO - 'talos_options': ['--disable-e10s'], 05:33:49 INFO - 'tests': ['damp', 'tps']}, 05:33:49 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 05:33:49 INFO - 'tests': ['damp', 'tps']}, 05:33:49 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:33:49 INFO - 'tests': ['dromaeo_dom']}, 05:33:49 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:33:49 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:33:49 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 05:33:49 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 05:33:49 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 05:33:49 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 05:33:49 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:33:49 INFO - 'tests': ['a11yr', 05:33:49 INFO - 'ts_paint', 05:33:49 INFO - 'tpaint', 05:33:49 INFO - 'sessionrestore', 05:33:49 INFO - 'sessionrestore_no_auto_restore', 05:33:49 INFO - 'tabpaint']}, 05:33:49 INFO - 'other-e10s': {'tests': ['a11yr', 05:33:49 INFO - 'ts_paint', 05:33:49 INFO - 'tpaint', 05:33:49 INFO - 'sessionrestore', 05:33:49 INFO - 'sessionrestore_no_auto_restore', 05:33:49 INFO - 'tabpaint']}, 05:33:49 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:33:49 INFO - 'ts_paint', 05:33:49 INFO - 'tpaint', 05:33:49 INFO - 'sessionrestore', 05:33:49 INFO - 'sessionrestore_no_auto_restore', 05:33:49 INFO - 'tabpaint']}, 05:33:49 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:33:49 INFO - 'ts_paint', 05:33:49 INFO - 'tpaint', 05:33:49 INFO - 'sessionrestore', 05:33:49 INFO - 'sessionrestore_no_auto_restore', 05:33:49 INFO - 'tabpaint']}, 05:33:49 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:33:49 INFO - 'tests': ['a11yr', 05:33:49 INFO - 'ts_paint', 05:33:49 INFO - 'tpaint', 05:33:49 INFO - 'sessionrestore', 05:33:49 INFO - 'sessionrestore_no_auto_restore', 05:33:49 INFO - 'tabpaint']}, 05:33:49 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:33:49 INFO - 'tests': ['a11yr', 05:33:49 INFO - 'ts_paint', 05:33:49 INFO - 'tpaint', 05:33:49 INFO - 'sessionrestore', 05:33:49 INFO - 'sessionrestore_no_auto_restore', 05:33:49 INFO - 'tabpaint']}, 05:33:49 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 05:33:49 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 05:33:49 INFO - 'bloom_basic_ref']}, 05:33:49 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set.zip', 05:33:49 INFO - 'talos_options': ['--mitmproxy', 05:33:49 INFO - 'mitmproxy-recording-1.mp', 05:33:49 INFO - '--firstNonBlankPaint'], 05:33:49 INFO - 'tests': ['Quantum_1']}, 05:33:49 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:33:49 INFO - 'tests': ['tsvgx', 05:33:49 INFO - 'tsvgr_opacity', 05:33:49 INFO - 'tart', 05:33:49 INFO - 'tscrollx', 05:33:49 INFO - 'cart', 05:33:49 INFO - 'tsvg_static']}, 05:33:49 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:33:49 INFO - 'tsvgr_opacity', 05:33:49 INFO - 'tart', 05:33:49 INFO - 'tscrollx', 05:33:49 INFO - 'cart', 05:33:49 INFO - 'tsvg_static']}, 05:33:49 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 05:33:49 INFO - 'talos_options': ['--disable-e10s'], 05:33:49 INFO - 'tests': ['tp5o']}, 05:33:49 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 05:33:49 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 05:33:49 INFO - 'talos_options': ['--disable-e10s', 05:33:49 INFO - '--xperf_path', 05:33:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:33:49 INFO - 'tests': ['tp5n']}, 05:33:49 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 05:33:49 INFO - 'talos_options': ['--xperf_path', 05:33:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:33:49 INFO - 'tests': ['tp5n']}}, 05:33:49 INFO - 'talos.zip': {'path': '', 05:33:49 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:33:49 INFO - Running post-action listener: _resource_record_post_action 05:33:49 INFO - [mozharness: 2017-06-07 12:33:49.214672Z] Finished populate-webroot step (success) 05:33:49 INFO - [mozharness: 2017-06-07 12:33:49.214768Z] Running create-virtualenv step. 05:33:49 INFO - Running pre-action listener: _resource_record_pre_action 05:33:49 INFO - Running main action method: create_virtualenv 05:33:49 INFO - Creating virtualenv /builds/slave/test/build/venv 05:33:49 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 05:33:49 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:33:49 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 05:33:49 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:33:49 INFO - Using real prefix '/usr' 05:33:49 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:33:49 INFO - Installing distribute.............................................................................................................................................................................................done. 05:33:51 INFO - Installing pip.................done. 05:33:51 INFO - Return code: 0 05:33:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 05:33:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 05:33:51 INFO - Reading from file tmpfile_stdout 05:33:51 INFO - Output received: 05:33:51 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) 05:33:51 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:33:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:33:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:33:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:33:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:33:51 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 0x14943b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x166ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18129a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1810140>, '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 0x1810a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1810ed0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1496838637.702639-1298006711', '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 05:33:51 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 05:33:51 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 05:33:51 INFO - Using env: {'DISPLAY': ':0', 05:33:51 INFO - 'HOME': '/home/cltbld', 05:33:51 INFO - 'LANG': 'en_US.UTF-8', 05:33:51 INFO - 'LANGUAGE': 'en_US:en', 05:33:51 INFO - 'LOGNAME': 'cltbld', 05:33:51 INFO - 'MAIL': '/var/mail/cltbld', 05:33:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:33:51 INFO - 'MOZ_NO_REMOTE': '1', 05:33:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:33:51 INFO - 'NO_EM_RESTART': '1', 05:33:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:33:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:33:51 INFO - 'PWD': '/builds/slave/test', 05:33:51 INFO - 'SHELL': '/bin/bash', 05:33:51 INFO - 'SHLVL': '1', 05:33:51 INFO - 'TERM': 'linux', 05:33:51 INFO - 'TMOUT': '86400', 05:33:51 INFO - 'USER': 'cltbld', 05:33:51 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1496838637.702639-1298006711', 05:33:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:33:51 INFO - '_': '/tools/buildbot/bin/python'} 05:33:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:33:52 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 05:33:52 INFO - Cleaning up... 05:33:52 INFO - Return code: 0 05:33:52 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:33:52 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')]} 05:33:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:33:52 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')]} 05:33:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:33:52 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 0x14943b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x166ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18129a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1810140>, '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 0x1810a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1810ed0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1496838637.702639-1298006711', '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 05:33:52 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 05:33:52 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 05:33:52 INFO - Using env: {'DISPLAY': ':0', 05:33:52 INFO - 'HOME': '/home/cltbld', 05:33:52 INFO - 'LANG': 'en_US.UTF-8', 05:33:52 INFO - 'LANGUAGE': 'en_US:en', 05:33:52 INFO - 'LOGNAME': 'cltbld', 05:33:52 INFO - 'MAIL': '/var/mail/cltbld', 05:33:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:33:52 INFO - 'MOZ_NO_REMOTE': '1', 05:33:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:33:52 INFO - 'NO_EM_RESTART': '1', 05:33:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:33:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:33:52 INFO - 'PWD': '/builds/slave/test', 05:33:52 INFO - 'SHELL': '/bin/bash', 05:33:52 INFO - 'SHLVL': '1', 05:33:52 INFO - 'TERM': 'linux', 05:33:52 INFO - 'TMOUT': '86400', 05:33:52 INFO - 'USER': 'cltbld', 05:33:52 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1496838637.702639-1298006711', 05:33:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:33:52 INFO - '_': '/tools/buildbot/bin/python'} 05:33:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:33:52 INFO - Downloading/unpacking psutil>=3.1.1 05:33:52 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 05:33:52 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 05:33:52 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 05:33:52 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 05:33:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:33:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:33:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:33:53 INFO - Installing collected packages: psutil 05:33:53 INFO - Running setup.py install for psutil 05:33:53 INFO - building 'psutil._psutil_linux' extension 05:33:53 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 05:33:53 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 05:33:53 INFO - building 'psutil._psutil_posix' extension 05:33:53 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 05:33:54 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 05:33:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:33:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:33:54 INFO - Successfully installed psutil 05:33:54 INFO - Cleaning up... 05:33:54 INFO - Return code: 0 05:33:54 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:33:54 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')]} 05:33:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:33:54 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')]} 05:33:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:33:54 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 0x14943b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x166ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18129a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1810140>, '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 0x1810a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1810ed0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1496838637.702639-1298006711', '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 05:33:54 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 05:33:54 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 05:33:54 INFO - Using env: {'DISPLAY': ':0', 05:33:54 INFO - 'HOME': '/home/cltbld', 05:33:54 INFO - 'LANG': 'en_US.UTF-8', 05:33:54 INFO - 'LANGUAGE': 'en_US:en', 05:33:54 INFO - 'LOGNAME': 'cltbld', 05:33:54 INFO - 'MAIL': '/var/mail/cltbld', 05:33:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:33:54 INFO - 'MOZ_NO_REMOTE': '1', 05:33:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:33:54 INFO - 'NO_EM_RESTART': '1', 05:33:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:33:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:33:54 INFO - 'PWD': '/builds/slave/test', 05:33:54 INFO - 'SHELL': '/bin/bash', 05:33:54 INFO - 'SHLVL': '1', 05:33:54 INFO - 'TERM': 'linux', 05:33:54 INFO - 'TMOUT': '86400', 05:33:54 INFO - 'USER': 'cltbld', 05:33:54 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1496838637.702639-1298006711', 05:33:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:33:54 INFO - '_': '/tools/buildbot/bin/python'} 05:33:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:33:54 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:33:54 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 05:33:54 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 05:33:54 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 05:33:54 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 05:33:55 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:33:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:33:55 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:33:55 INFO - Installing collected packages: mozsystemmonitor 05:33:55 INFO - Running setup.py install for mozsystemmonitor 05:33:55 INFO - Successfully installed mozsystemmonitor 05:33:55 INFO - Cleaning up... 05:33:55 INFO - Return code: 0 05:33:55 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:33:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:33:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:33:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:33:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:33:55 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 0x14943b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x166ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18129a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1810140>, '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 0x1810a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1810ed0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1496838637.702639-1298006711', '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 05:33:55 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 05:33:55 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 05:33:55 INFO - Using env: {'DISPLAY': ':0', 05:33:55 INFO - 'HOME': '/home/cltbld', 05:33:55 INFO - 'LANG': 'en_US.UTF-8', 05:33:55 INFO - 'LANGUAGE': 'en_US:en', 05:33:55 INFO - 'LOGNAME': 'cltbld', 05:33:55 INFO - 'MAIL': '/var/mail/cltbld', 05:33:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:33:55 INFO - 'MOZ_NO_REMOTE': '1', 05:33:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:33:55 INFO - 'NO_EM_RESTART': '1', 05:33:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:33:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:33:55 INFO - 'PWD': '/builds/slave/test', 05:33:55 INFO - 'SHELL': '/bin/bash', 05:33:55 INFO - 'SHLVL': '1', 05:33:55 INFO - 'TERM': 'linux', 05:33:55 INFO - 'TMOUT': '86400', 05:33:55 INFO - 'USER': 'cltbld', 05:33:55 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1496838637.702639-1298006711', 05:33:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:33:55 INFO - '_': '/tools/buildbot/bin/python'} 05:33:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:33:55 INFO - Downloading/unpacking jsonschema==2.5.1 05:33:55 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 05:33:55 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 05:33:55 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 05:33:55 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 05:33:56 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:33:56 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:33:56 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 05:33:56 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 05:33:56 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 05:33:56 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 05:33:57 INFO - Downloading functools32-3.2.3-2.tar.gz 05:33:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:33:57 INFO - warning: no files found matching '*.txt' 05:33:57 INFO - no previously-included directories found matching 'build' 05:33:57 INFO - no previously-included directories found matching 'dist' 05:33:57 INFO - no previously-included directories found matching '.git*' 05:33:57 INFO - Installing collected packages: jsonschema, functools32 05:33:57 INFO - Running setup.py install for functools32 05:33:57 INFO - warning: no files found matching '*.txt' 05:33:57 INFO - no previously-included directories found matching 'build' 05:33:57 INFO - no previously-included directories found matching 'dist' 05:33:57 INFO - no previously-included directories found matching '.git*' 05:33:57 INFO - Successfully installed jsonschema functools32 05:33:57 INFO - Cleaning up... 05:33:57 INFO - Return code: 0 05:33:57 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:33:57 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')]} 05:33:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:33:57 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')]} 05:33:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:33:57 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 0x14943b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x166ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18129a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1810140>, '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 0x1810a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1810ed0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1496838637.702639-1298006711', '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 05:33:57 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 05:33:57 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 05:33:57 INFO - Using env: {'DISPLAY': ':0', 05:33:57 INFO - 'HOME': '/home/cltbld', 05:33:57 INFO - 'LANG': 'en_US.UTF-8', 05:33:57 INFO - 'LANGUAGE': 'en_US:en', 05:33:57 INFO - 'LOGNAME': 'cltbld', 05:33:57 INFO - 'MAIL': '/var/mail/cltbld', 05:33:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:33:57 INFO - 'MOZ_NO_REMOTE': '1', 05:33:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:33:57 INFO - 'NO_EM_RESTART': '1', 05:33:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:33:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:33:57 INFO - 'PWD': '/builds/slave/test', 05:33:57 INFO - 'SHELL': '/bin/bash', 05:33:57 INFO - 'SHLVL': '1', 05:33:57 INFO - 'TERM': 'linux', 05:33:57 INFO - 'TMOUT': '86400', 05:33:57 INFO - 'USER': 'cltbld', 05:33:57 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1496838637.702639-1298006711', 05:33:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:33:57 INFO - '_': '/tools/buildbot/bin/python'} 05:33:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:33:57 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:33:57 INFO - Cleaning up... 05:33:57 INFO - Return code: 0 05:33:57 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:33:57 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')]} 05:33:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:33:57 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')]} 05:33:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:33:57 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 0x14943b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x166ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18129a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1810140>, '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 0x1810a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1810ed0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1496838637.702639-1298006711', '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 05:33:57 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 05:33:57 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 05:33:57 INFO - Using env: {'DISPLAY': ':0', 05:33:57 INFO - 'HOME': '/home/cltbld', 05:33:57 INFO - 'LANG': 'en_US.UTF-8', 05:33:57 INFO - 'LANGUAGE': 'en_US:en', 05:33:57 INFO - 'LOGNAME': 'cltbld', 05:33:57 INFO - 'MAIL': '/var/mail/cltbld', 05:33:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:33:57 INFO - 'MOZ_NO_REMOTE': '1', 05:33:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:33:57 INFO - 'NO_EM_RESTART': '1', 05:33:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:33:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:33:57 INFO - 'PWD': '/builds/slave/test', 05:33:57 INFO - 'SHELL': '/bin/bash', 05:33:57 INFO - 'SHLVL': '1', 05:33:57 INFO - 'TERM': 'linux', 05:33:57 INFO - 'TMOUT': '86400', 05:33:57 INFO - 'USER': 'cltbld', 05:33:57 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1496838637.702639-1298006711', 05:33:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:33:57 INFO - '_': '/tools/buildbot/bin/python'} 05:33:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:33:57 INFO - Downloading/unpacking blobuploader==1.2.4 05:33:57 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 05:33:57 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 05:33:57 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 05:33:57 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 05:33:58 INFO - Downloading blobuploader-1.2.4.tar.gz 05:33:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:33:58 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:33:58 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 05:33:58 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 05:33:58 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 05:33:58 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 05:33:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:33:59 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:33:59 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 05:33:59 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 05:33:59 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 05:33:59 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 05:33:59 INFO - Downloading docopt-0.6.1.tar.gz 05:33:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:33:59 INFO - Installing collected packages: blobuploader, requests, docopt 05:33:59 INFO - Running setup.py install for blobuploader 05:33:59 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:33:59 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:33:59 INFO - Running setup.py install for requests 05:33:59 INFO - Running setup.py install for docopt 05:33:59 INFO - Successfully installed blobuploader requests docopt 05:33:59 INFO - Cleaning up... 05:34:00 INFO - Return code: 0 05:34:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:34: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')]} 05:34:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:34: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')]} 05:34:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:34:00 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 0x14943b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x166ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18129a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1810140>, '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 0x1810a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1810ed0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1496838637.702639-1298006711', '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 05:34:00 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 05:34:00 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 05:34:00 INFO - Using env: {'DISPLAY': ':0', 05:34:00 INFO - 'HOME': '/home/cltbld', 05:34:00 INFO - 'LANG': 'en_US.UTF-8', 05:34:00 INFO - 'LANGUAGE': 'en_US:en', 05:34:00 INFO - 'LOGNAME': 'cltbld', 05:34:00 INFO - 'MAIL': '/var/mail/cltbld', 05:34:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:34:00 INFO - 'MOZ_NO_REMOTE': '1', 05:34:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:34:00 INFO - 'NO_EM_RESTART': '1', 05:34:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:34:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:34:00 INFO - 'PWD': '/builds/slave/test', 05:34:00 INFO - 'SHELL': '/bin/bash', 05:34:00 INFO - 'SHLVL': '1', 05:34:00 INFO - 'TERM': 'linux', 05:34:00 INFO - 'TMOUT': '86400', 05:34:00 INFO - 'USER': 'cltbld', 05:34:00 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1496838637.702639-1298006711', 05:34:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:34:00 INFO - '_': '/tools/buildbot/bin/python'} 05:34:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:34:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:34:00 INFO - Running setup.py (path:/tmp/pip-aeXhlA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:34:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:34:00 INFO - Running setup.py (path:/tmp/pip-oL3nGD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:34:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:34:00 INFO - Running setup.py (path:/tmp/pip-k6eCpc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:34:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:34:00 INFO - Running setup.py (path:/tmp/pip-Rv3vvT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:34:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:34:00 INFO - Running setup.py (path:/tmp/pip-x2Osj8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:34:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:34:00 INFO - Running setup.py (path:/tmp/pip-9gMcZ4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:34:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:34:00 INFO - Running setup.py (path:/tmp/pip-J6zXxy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:34:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:34:00 INFO - Running setup.py (path:/tmp/pip-YQTObN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:34:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:34:00 INFO - Running setup.py (path:/tmp/pip-o0Ubpn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:34:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:34:00 INFO - Running setup.py (path:/tmp/pip-yzpXDA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:34:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:34:00 INFO - Running setup.py (path:/tmp/pip-Ti1CNh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:34:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:34:01 INFO - Running setup.py (path:/tmp/pip-dMxWmn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:34:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:34:01 INFO - Running setup.py (path:/tmp/pip-itbn7F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:34:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:34:01 INFO - Running setup.py (path:/tmp/pip-ZMkXdy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:34:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:34:01 INFO - Running setup.py (path:/tmp/pip-2_g_ri-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:34:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:34:01 INFO - Running setup.py (path:/tmp/pip-hKKM4I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:34:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:34:01 INFO - Running setup.py (path:/tmp/pip-Gc3ryv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:34:01 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:34:01 INFO - Running setup.py install for manifestparser 05:34:01 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:34:01 INFO - Running setup.py install for mozcrash 05:34:01 INFO - Running setup.py install for mozdebug 05:34:01 INFO - Running setup.py install for mozdevice 05:34:01 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:34:01 INFO - Running setup.py install for mozfile 05:34:01 INFO - Running setup.py install for mozhttpd 05:34:02 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:34:02 INFO - Running setup.py install for mozinfo 05:34:02 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:34:02 INFO - Running setup.py install for mozInstall 05:34:02 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:34:02 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:34:02 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:34:02 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:34:02 INFO - Running setup.py install for mozleak 05:34:02 INFO - Running setup.py install for mozlog 05:34:02 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:34:02 INFO - Running setup.py install for moznetwork 05:34:02 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:34:02 INFO - Running setup.py install for mozprocess 05:34:02 INFO - Running setup.py install for mozprofile 05:34:02 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:34:02 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:34:02 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:34:02 INFO - Running setup.py install for mozrunner 05:34:02 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:34:02 INFO - Running setup.py install for mozscreenshot 05:34:03 INFO - Running setup.py install for moztest 05:34:03 INFO - Running setup.py install for mozversion 05:34:03 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:34:03 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:34:03 INFO - Cleaning up... 05:34:03 INFO - Return code: 0 05:34:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:34:03 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')]} 05:34:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:34:03 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')]} 05:34:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:34:03 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 0x14943b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x166ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18129a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1810140>, '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 0x1810a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1810ed0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1496838637.702639-1298006711', '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 05:34:03 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 05:34:03 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 05:34:03 INFO - Using env: {'DISPLAY': ':0', 05:34:03 INFO - 'HOME': '/home/cltbld', 05:34:03 INFO - 'LANG': 'en_US.UTF-8', 05:34:03 INFO - 'LANGUAGE': 'en_US:en', 05:34:03 INFO - 'LOGNAME': 'cltbld', 05:34:03 INFO - 'MAIL': '/var/mail/cltbld', 05:34:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:34:03 INFO - 'MOZ_NO_REMOTE': '1', 05:34:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:34:03 INFO - 'NO_EM_RESTART': '1', 05:34:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:34:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:34:03 INFO - 'PWD': '/builds/slave/test', 05:34:03 INFO - 'SHELL': '/bin/bash', 05:34:03 INFO - 'SHLVL': '1', 05:34:03 INFO - 'TERM': 'linux', 05:34:03 INFO - 'TMOUT': '86400', 05:34:03 INFO - 'USER': 'cltbld', 05:34:03 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1496838637.702639-1298006711', 05:34:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:34:03 INFO - '_': '/tools/buildbot/bin/python'} 05:34:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:34:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:34:03 INFO - Running setup.py (path:/tmp/pip-6a6Q9d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:34:03 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)) 05:34:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:34:03 INFO - Running setup.py (path:/tmp/pip-iWZf0w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:34:03 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)) 05:34:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:34:03 INFO - Running setup.py (path:/tmp/pip-7_F60B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:34:03 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)) 05:34:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:34:03 INFO - Running setup.py (path:/tmp/pip-GAltYy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:34:03 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)) 05:34:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:34:03 INFO - Running setup.py (path:/tmp/pip-IYVaLI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:34:03 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)) 05:34:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:34:03 INFO - Running setup.py (path:/tmp/pip-HH2gTe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:34:03 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)) 05:34:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:34:03 INFO - Running setup.py (path:/tmp/pip-a1kn6T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:34:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.10 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 05:34:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:34:03 INFO - Running setup.py (path:/tmp/pip-yZX5rD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:34:04 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)) 05:34:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:34:04 INFO - Running setup.py (path:/tmp/pip-zjQnI1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:34:04 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)) 05:34:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:34:04 INFO - Running setup.py (path:/tmp/pip-t4wc0S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:34:04 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)) 05:34:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:34:04 INFO - Running setup.py (path:/tmp/pip-LVjlGK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:34:04 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)) 05:34:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:34:04 INFO - Running setup.py (path:/tmp/pip-swiqtj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:34:04 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)) 05:34:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:34:04 INFO - Running setup.py (path:/tmp/pip-HLmhvN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:34:04 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)) 05:34:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:34:04 INFO - Running setup.py (path:/tmp/pip-PK3V6X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:34:04 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)) 05:34:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:34:04 INFO - Running setup.py (path:/tmp/pip-U3nyKG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:34:04 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)) 05:34:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:34:04 INFO - Running setup.py (path:/tmp/pip-JVheDj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:34:04 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)) 05:34:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:34:04 INFO - Running setup.py (path:/tmp/pip-5ZQo1w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:34:04 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)) 05:34:04 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)) 05:34:04 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)) 05:34:04 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)) 05:34:04 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)) 05:34:04 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)) 05:34:04 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:34: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 05:34: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 05:34: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 05:34: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 05:34:05 INFO - Downloading blessings-1.6.tar.gz 05:34:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:34:05 INFO - Installing collected packages: blessings 05:34:05 INFO - Running setup.py install for blessings 05:34:05 INFO - Successfully installed blessings 05:34:05 INFO - Cleaning up... 05:34:06 INFO - Return code: 0 05:34:06 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:34:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:34:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:34:06 INFO - Reading from file tmpfile_stdout 05:34:06 INFO - Current package versions: 05:34:06 INFO - argparse == 1.2.1 05:34:06 INFO - blessings == 1.6 05:34:06 INFO - blobuploader == 1.2.4 05:34:06 INFO - docopt == 0.6.1 05:34:06 INFO - functools32 == 3.2.3-2 05:34:06 INFO - jsonschema == 2.5.1 05:34:06 INFO - manifestparser == 1.1 05:34:06 INFO - mozInstall == 1.12 05:34:06 INFO - mozcrash == 1.0 05:34:06 INFO - mozdebug == 0.1 05:34:06 INFO - mozdevice == 0.51 05:34:06 INFO - mozfile == 1.2 05:34:06 INFO - mozhttpd == 0.7 05:34:06 INFO - mozinfo == 0.10 05:34:06 INFO - mozleak == 0.1 05:34:06 INFO - mozlog == 3.4 05:34:06 INFO - moznetwork == 0.27 05:34:06 INFO - mozprocess == 0.25 05:34:06 INFO - mozprofile == 0.28 05:34:06 INFO - mozrunner == 6.13 05:34:06 INFO - mozscreenshot == 0.1 05:34:06 INFO - mozsystemmonitor == 0.3 05:34:06 INFO - moztest == 0.8 05:34:06 INFO - mozversion == 1.4 05:34:06 INFO - psutil == 3.1.1 05:34:06 INFO - requests == 1.2.3 05:34:06 INFO - wsgiref == 0.1.2 05:34:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:34: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')]} 05:34:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:34: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')]} 05:34:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:34:06 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 0x14943b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x166ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18129a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1810140>, '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 0x1810a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1810ed0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1496838637.702639-1298006711', '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 05:34:06 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 05:34:06 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 05:34:06 INFO - Using env: {'DISPLAY': ':0', 05:34:06 INFO - 'HOME': '/home/cltbld', 05:34:06 INFO - 'LANG': 'en_US.UTF-8', 05:34:06 INFO - 'LANGUAGE': 'en_US:en', 05:34:06 INFO - 'LOGNAME': 'cltbld', 05:34:06 INFO - 'MAIL': '/var/mail/cltbld', 05:34:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:34:06 INFO - 'MOZ_NO_REMOTE': '1', 05:34:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:34:06 INFO - 'NO_EM_RESTART': '1', 05:34:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:34:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:34:06 INFO - 'PWD': '/builds/slave/test', 05:34:06 INFO - 'SHELL': '/bin/bash', 05:34:06 INFO - 'SHLVL': '1', 05:34:06 INFO - 'TERM': 'linux', 05:34:06 INFO - 'TMOUT': '86400', 05:34:06 INFO - 'USER': 'cltbld', 05:34:06 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1496838637.702639-1298006711', 05:34:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:34:06 INFO - '_': '/tools/buildbot/bin/python'} 05:34:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:34:06 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)) 05:34:06 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)) 05:34:06 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)) 05:34:06 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)) 05:34:06 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)) 05:34:06 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)) 05:34:06 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)) 05:34:06 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)) 05:34:06 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)) 05:34:06 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 05:34: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 05:34: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 05:34: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 05:34: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 05:34:07 INFO - Downloading marionette_driver-1.4.0.tar.gz 05:34:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 05:34:07 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)) 05:34:07 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)) 05:34:07 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)) 05:34:07 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)) 05:34:07 INFO - Installing collected packages: marionette-driver 05:34:07 INFO - Running setup.py install for marionette-driver 05:34:07 INFO - Successfully installed marionette-driver 05:34:07 INFO - Cleaning up... 05:34:07 INFO - Return code: 0 05:34:07 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:34:07 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')]} 05:34:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:34:07 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')]} 05:34:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:34:07 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 0x14943b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x166ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18129a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1810140>, '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 0x1810a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1810ed0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1496838637.702639-1298006711', '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 05:34:07 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 05:34:07 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 05:34:07 INFO - Using env: {'DISPLAY': ':0', 05:34:07 INFO - 'HOME': '/home/cltbld', 05:34:07 INFO - 'LANG': 'en_US.UTF-8', 05:34:07 INFO - 'LANGUAGE': 'en_US:en', 05:34:07 INFO - 'LOGNAME': 'cltbld', 05:34:07 INFO - 'MAIL': '/var/mail/cltbld', 05:34:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:34:07 INFO - 'MOZ_NO_REMOTE': '1', 05:34:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:34:07 INFO - 'NO_EM_RESTART': '1', 05:34:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:34:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:34:07 INFO - 'PWD': '/builds/slave/test', 05:34:07 INFO - 'SHELL': '/bin/bash', 05:34:07 INFO - 'SHLVL': '1', 05:34:07 INFO - 'TERM': 'linux', 05:34:07 INFO - 'TMOUT': '86400', 05:34:07 INFO - 'USER': 'cltbld', 05:34:07 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1496838637.702639-1298006711', 05:34:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:34:07 INFO - '_': '/tools/buildbot/bin/python'} 05:34:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:34:08 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:34:08 INFO - Cleaning up... 05:34:08 INFO - Return code: 0 05:34:08 INFO - Running post-action listener: _resource_record_post_action 05:34:08 INFO - Running post-action listener: _start_resource_monitoring 05:34:08 INFO - Starting resource monitoring. 05:34:08 INFO - [mozharness: 2017-06-07 12:34:08.076615Z] Finished create-virtualenv step (success) 05:34:08 INFO - [mozharness: 2017-06-07 12:34:08.077072Z] Running install step. 05:34:08 INFO - Running pre-action listener: _resource_record_pre_action 05:34:08 INFO - Running main action method: install 05:34:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:34:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:34:08 INFO - Reading from file tmpfile_stdout 05:34:08 INFO - Detecting whether we're running mozinstall >=1.0... 05:34:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:34:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:34:08 INFO - Reading from file tmpfile_stdout 05:34:08 INFO - Output received: 05:34:08 INFO - Usage: mozinstall [options] installer 05:34:08 INFO - Options: 05:34:08 INFO - -h, --help show this help message and exit 05:34:08 INFO - -d DEST, --destination=DEST 05:34:08 INFO - Directory to install application into. [default: 05:34:08 INFO - "/builds/slave/test"] 05:34:08 INFO - --app=APP Application being installed. [default: firefox] 05:34:08 INFO - mkdir: /builds/slave/test/build/application 05:34:08 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'] 05:34:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 05:34:25 INFO - Reading from file tmpfile_stdout 05:34:25 INFO - Output received: 05:34:25 INFO - /builds/slave/test/build/application/firefox/firefox 05:34:25 INFO - Running post-action listener: _resource_record_post_action 05:34:25 INFO - [mozharness: 2017-06-07 12:34:25.257972Z] Finished install step (success) 05:34:25 INFO - [mozharness: 2017-06-07 12:34:25.258251Z] Running setup-mitmproxy step. 05:34:25 INFO - Running pre-action listener: _resource_record_pre_action 05:34:25 INFO - Running main action method: setup_mitmproxy 05:34:25 INFO - Skipping: mitmproxy is not required 05:34:25 INFO - Running post-action listener: _resource_record_post_action 05:34:25 INFO - [mozharness: 2017-06-07 12:34:25.259418Z] Finished setup-mitmproxy step (success) 05:34:25 INFO - [mozharness: 2017-06-07 12:34:25.259637Z] Running run-tests step. 05:34:25 INFO - Running pre-action listener: _resource_record_pre_action 05:34:25 INFO - Running main action method: run_tests 05:34:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:34:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:34:25 INFO - Python 2.7.3 05:34:25 INFO - Return code: 0 05:34:25 INFO - grabbing minidump binary from tooltool 05:34:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:34:25 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 0x1810140>, '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 0x1810a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1810ed0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:34:25 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 05:34:25 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 05:34:25 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 05:34:25 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:34:25 INFO - Return code: 0 05:34:25 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:34:25 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:34:25 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:34:25 INFO - ENV: RUST_BACKTRACE is now 1 05:34:25 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:34:25 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:34:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/H4Wo3ZRMQ7iGiSIB2eANQw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-012', '--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 05:34:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/H4Wo3ZRMQ7iGiSIB2eANQw/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-012 --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 05:34:25 INFO - Using env: {'DISPLAY': ':0', 05:34:25 INFO - 'HOME': '/home/cltbld', 05:34:25 INFO - 'LANG': 'en_US.UTF-8', 05:34:25 INFO - 'LANGUAGE': 'en_US:en', 05:34:25 INFO - 'LOGNAME': 'cltbld', 05:34:25 INFO - 'MAIL': '/var/mail/cltbld', 05:34:25 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:34:25 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:34:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:34:25 INFO - 'MOZ_NO_REMOTE': '1', 05:34:25 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:34:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:34:25 INFO - 'NO_EM_RESTART': '1', 05:34:25 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:34:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:34:25 INFO - 'PWD': '/builds/slave/test', 05:34:25 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:34:25 INFO - 'RUST_BACKTRACE': '1', 05:34:25 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 05:34:25 INFO - 'SHELL': '/bin/bash', 05:34:25 INFO - 'SHLVL': '1', 05:34:25 INFO - 'TERM': 'linux', 05:34:25 INFO - 'TMOUT': '86400', 05:34:25 INFO - 'USER': 'cltbld', 05:34:25 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1496838637.702639-1298006711', 05:34:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:34:25 INFO - '_': '/tools/buildbot/bin/python'} 05:34:25 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/H4Wo3ZRMQ7iGiSIB2eANQw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-012', '--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 05:34:25 INFO - mozversion application_buildid: 20170607113506 05:34:25 INFO - mozversion application_changeset: fb40bcb6155bd1e3ac5468ff4575cce171efbc12 05:34:25 INFO - mozversion application_display_name: Nightly 05:34:25 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:34:25 INFO - mozversion application_name: Firefox 05:34:25 INFO - mozversion application_remotingname: firefox 05:34:25 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:34:25 INFO - mozversion application_vendor: Mozilla 05:34:25 INFO - mozversion application_version: 55.0a1 05:34:25 INFO - mozversion platform_buildid: 20170607113506 05:34:25 INFO - mozversion platform_changeset: fb40bcb6155bd1e3ac5468ff4575cce171efbc12 05:34:25 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:34:25 INFO - mozversion platform_version: 55.0a1 05:34:25 INFO - using testdate: 1496838865 05:34:25 INFO - actual date: 1496838865 05:34:25 INFO - starting webserver on 'localhost:48162' 05:34:25 INFO - SUITE-START | Running 2 tests 05:34:25 INFO - TEST-START | dromaeo_css 05:34:25 INFO - operating with platform_type : linux_ 05:34:25 INFO - Initialising browser for dromaeo_css test... 05:34:25 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:48162/getInfo.html -profile /tmp/tmpTlJAgj/profile 05:34:25 INFO - TEST-INFO | started process 4847 (/builds/slave/test/build/application/firefox/firefox http://localhost:48162/getInfo.html) 05:34:59 INFO - TEST-INFO | 4847: killed by SIGTERM 05:34:59 INFO - Browser initialized. 05:34:59 INFO - Running cycle 1/1 for dromaeo_css test... 05:34:59 INFO - TEST-INFO | started process 5055 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpTlJAgj/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:35:11 INFO - PID 5055 | RSS: Main: 177254400 05:35:11 INFO - PID 5055 | 05:38:11 INFO - PID 5055 | Cycle 1(1): loaded http://localhost:48162/tests/dromaeo/cssquery-dojo.html (next: http://localhost:48162/tests/dromaeo/cssquery-ext.html) 05:38:13 INFO - PID 5055 | RSS: Main: 176021504 05:38:13 INFO - PID 5055 | 05:41:14 INFO - PID 5055 | Cycle 1(1): loaded http://localhost:48162/tests/dromaeo/cssquery-ext.html (next: http://localhost:48162/tests/dromaeo/cssquery-jquery.html) 05:41:15 INFO - PID 5055 | RSS: Main: 179040256 05:41:15 INFO - PID 5055 | 05:44:17 INFO - PID 5055 | Cycle 1(1): loaded http://localhost:48162/tests/dromaeo/cssquery-jquery.html (next: http://localhost:48162/tests/dromaeo/cssquery-mootools.html) 05:44:17 INFO - PID 5055 | RSS: Main: 176320512 05:44:17 INFO - PID 5055 | 05:47:19 INFO - PID 5055 | Cycle 1(1): loaded http://localhost:48162/tests/dromaeo/cssquery-mootools.html (next: http://localhost:48162/tests/dromaeo/cssquery-prototype.html) 05:47:20 INFO - PID 5055 | RSS: Main: 179449856 05:47:20 INFO - PID 5055 | 05:50:22 INFO - PID 5055 | Cycle 1(1): loaded http://localhost:48162/tests/dromaeo/cssquery-prototype.html (next: http://localhost:48162/tests/dromaeo/cssquery-yui.html) 05:50:23 INFO - PID 5055 | RSS: Main: 178470912 05:50:23 INFO - PID 5055 | 05:53:24 INFO - PID 5055 | Cycle 1(1): loaded http://localhost:48162/tests/dromaeo/cssquery-yui.html (next: http://localhost:48162/tests/dromaeo/cssquery-dojo.html) 05:53:25 INFO - PID 5055 | RSS: Main: 179724288 05:53:25 INFO - PID 5055 | 05:53:25 INFO - PID 5055 | __start_tp_report 05:53:25 INFO - PID 5055 | _x_x_mozilla_page_load 05:53:25 INFO - PID 5055 | _x_x_mozilla_page_load_details 05:53:25 INFO - PID 5055 | |i|pagename|runs| 05:53:25 INFO - PID 5055 | |0;dojo.html;3382.4926261060837;3403.4044042292594;3417.5044618530314;3418.572678415198;3420.4527275635905;5904.143899134623;5962.195103661004;5966.4928481079105;6012.969935150318;6032.4269194426515;5954.880902381949;5986.850328741783;5995;6036;6107.175531303273;4958.776855041532;5208.385300779264;5281.970015846901;5301.549368303679;5369.167778994262;5382.1119515280125;5442.2380866678695;5443.755031023594;5446.91829622556;5453.590980676465;5280.3663560373;5311.548518375904;5350.625456218067;5393.9730301348245;5429.647072940246;5445.782168713246;5446.618736688433;5446.972765136149;5450.073487507133;5466.808661696821;5402.486763757437;5421;5431.592630552725;5433;5441.863953401157;5879.706014699248;5959.344472108108;5984.551158663074;6009.06859436788;6036.758529658809;6442.742290308382;6492.448141907944;6503.187101612299;6510.479161667055;6510.707018184145;6493.870122597522;6516.218053833571;6549.967250163766;6562.507811914078;6576.967115164442;6013.338532761392;6014.51883849291;6036.698165091728;6097.115918191837;6104.145419641254;6691.732330706717;6704.932950670431;6719.496037797185;6724.731010759613;6764.120664313607;6173.567850250529;6201.751929922752;6308.053791931247;6437.485001199892;6446.484281257488;6490.643014634241;6572.244191917895;6574.671266436659;6578.967105164444;6592.110065141144;6353.841153971188;6396.168498095218;6514.869702605922;6556.704948277339;6567.080608714784;6474.352564743582;6489.610623362613;6496.6426846522945;6504.609723416515;6553.672316384257;4955.331030310934;4970.378702662168;4970.602351811846;4973.378327709036;4975.228839529878;4365.519792822787;4365.9126817463475;4382.583654552813;4389.188000219906;4415.139047885696;5900.20347253124;5969.2240008799445;6104.328523862371;6129.693515324216;6139.706800529493;6601.504887133388;6634.369734875179;6637.070810086591;6637.601743895285;6637.668116594151;6159.599626024294;6160.722767475474;6171.197744293213;6177;6187.319394866561;5438.211459338374;5451.727413629303;5480.232767412565;5502.2296878437055;5532.861678458071;6759.898601520981;6787.558808677519;6800.183977922582;6817.590944543244;6829.112215411965;6564.606123632598;6614.239362473377;6625.635590042594;6628.337166283333;6635.867282654416;6565.474762018932;6681.398674119353;6791.762288319885;6827.317268273133;6829.897551536632;6358;6377.1390862233;6402.807915762534;6407.743690252338;6433.035044743326;6677.766278180435;6682.3317668232785;6691.364320389555;6692.364225398579;6698.162729658793;6261.217347831521;6278.372162783685;6305.243370795534;6371.872562548816;6446.323136070832;6365.61806291624;6387.265464471645;6392.105105285357;6393.552451328548;6406.743730250738;6345.809625711236;6379.266384365672;6390.5526613136635;6391.009393544008;6394.936050639621;6313.084602732486;6363.681815909279;6371.426571608577;6427.035944608346;6433.581817181868;6281.246250449975;6315.179026726496;6332.905006425;6341.175647165839;6342.809715708536 05:53:25 INFO - PID 5055 | |1;ext.html;745.500514655181;813.5891374855697;826.7106512720549;1100.262823907982;1106.4910141334985;37598;38312.23375532491;38314.8084259579;38384.616153838455;38475.807620961925;40432;40943.18113637726;41031;41073.38389924153;41086.7945660272;7118.78643640689;7125.180604230528;7210.098737657793;7256.346928776409;7367.705291788322;7290.635468226594;7312.634368281565;7350.4854660173805;7368.042154519905;7368.300011498899;7296.489245752799;7420.777376678709;7423.1463381711255;7436.888446673304;7437.107547094356;7347.1550771661405;7349.963250183715;7350.044494215745;7360.07999000125;7381.9261807382045;6955.65221738911;7008.789736307919;7013.544119632259;7023.332783385621;7025.19210290818;37576.62423375758;37625;37940.810295948344;37946.81026594877;37950;3473.593194756128;3498.6501349865066;3516.507688923553;3532.7527073104893;3538.097785064818;29267.853660731562;29497.41005179906;29591.852040739657;29636.555451668242;29791.55312670312;3694.8891533254045;3724.8696295629793;3725.8137093145506;3733.328000959826;3736.4208547675153;153743;153986;155246.22376888155;194035;195243;42192.789036055234;42628.1474370517;42646.78676606597;42701.786491067345;42770.35844462336;44288.77855610701;44399.55600444019;44428;44630.776846115565;44689.55310446919;14939.626509337353;15087.4719384821;15096.320665570076;15105;15126.168060756763;12125.39373031345;12217.144799863925;12229.327386993622;12230.816537751942;12238.510459581696;14432;14475.565733028026;14518.564443066725;14608.64523932093;14831.18428486422;5715.8856822864145;5888.676122813286;5923.644581325048;6039.486643635252;6094.908576371358;1037.3568387599737;1051.3429106808244;1059.2638116509106;1076.5048077884105;1096.6326280696055;24979.250622481355;25290;25581.616275755878;25594.74405255961;25739.485210296065;1151.2746969409218;1166.3060479014973;1192.791261529229;1200.6038007457519;1213.2235369363614;13031.869681303255;13667.521636742666;13690.452381904812;13905.513307034407;13906.40076391228;225271;227840;229132;230905;256941;54221.1866821998;55190;55456.16815747767;55491.72254138784;55603.721981389834;1476.2249818844978;1477.5124209011;1491.209658880795;1500.1224283793886;1507.6984603079427;29082.41835163327;30471.542926855673;30804.22989425282;31300;31360.843195783877;39892.2021559573;51080.48919510757;51357.22964155615;51692.74153629208;51907.74046129745;227013;229622;230311;230878;231096;36063.63936360708;36988.44517332296;37429.251414971004;37500;38137.80931095438;47277.29084063673;47676.761616191696;47938.5206147948;48541.27188092252;48742;33904.491432628034;34468.65531344755;34733.65266347304;35071.824640876635;36143.37354818987;34148;35113.47329790004;35192.120196994256;35522;35789.46315805317;41616;41648.375274371516;41726.374104387854;41728;41752;31459;31958.68041319557;32121.196970075936;33220;34497.31005379828;26559.98244100048;28264.85867570649;28470.715292846806;28541.714582854736;28725.28186795347 05:53:25 INFO - PID 5055 | |2;jquery.html;436.491487417159;437.5230998211948;441.97348159110453;457.6247477068804;459.61851663119614;15391.461298854543;15942.123183224918;20570.48573785656;21443.67834482482;21503.46241343965;22219.44451388716;22751.544969100607;22852.200172993947;22886.198983035596;22955.770442295572;5587.217789509472;5704.172894930232;5736.799212027579;5757.021306377926;5775.942240577582;5613.578981576377;5674.914876276859;5691.630044047124;5695.8576035599235;5700.173474846145;5383.81156659517;5599.468050535193;5626.071698169797;5659.009673307155;5675.489205971462;5578.0517312056645;5601.383847776741;5602.327720673525;5624.465675760796;5632.802851900205;5106.106431374532;5137.768800403991;5152.484751524855;5160.432352441228;5161.406438259611;25520.87239563809;25834.095806646867;26064.34839129018;26104.86947565269;26259;2186.8578542394694;2211.8230541556636;2217.46780772615;2229.041512149775;2229.498362868358;16540.255688493926;17319;17372.65254694899;17462.388816391493;17465.126743662768;1991.442396129086;2011.5976804638985;2016.2942969960543;2021.9696704549444;2033.6542787725973;118069.40965295205;118982;120826.39586802098;120999;121243.3937830314;11958.940205298917;11979.940100299442;12413.131080824256;12423.31671758044;12878.67803304925;17893.19480623375;17898.015609141363;18010.819891801177;18055.458336249932;18067.277308907498;8985.730428087169;9088.136627020422;9162;9211.585478653342;9256.8611470828;8531.10423405546;8793.560321983876;8852.601632926533;8903.599338029804;8983.910160898307;7173.92826071743;7395.704171833174;7984.281414672591;8107.432479726481;8206.466579672302;2302.815774738017;2307.3308740465077;2319.2810228829117;2347.9924664411683;2469.901203951858;1016.207358260558;1020.6682828080903;1024.8462730590322;1035.316690983947;1036.7200855769051;19804.60390792205;20172.39482815518;20325.79674203239;20441.284555040504;20737.27419540309;1020.7856350166549;1033.2767063055742;1054.130342467452;1075.521392980132;1076.5263284154946;10734.677959661223;10974.231803773659;11053.557857685602;11282.774344513064;11397.373144476967;483778;500079;516669.40253590536;519016;522612;98310.50844745873;99048;99653.50173249232;99662.5016874911;100610;1143.0798207442922;1166.836642869999;1186.6736647421856;1190.077689790402;1194.3908606610692;16488.505344839676;16652;16692.332306707594;17795.46613601594;17874.5531361717;49095.754521227165;49684.75157624333;50830.23754643757;51069.489305107956;51710.22434663558;63423.68288158529;63634;63714;63878.36121638724;64164.35835641584;9365.812683746422;10268.435236062089;10619;10750.301230419998;10791.082757965662;16771.32914683399;16774.0774257417;16790.160491975108;16929.492115236564;16975.23611437513;15026.6994660104;15239.238038097828;15271.312790924658;15290.77063844021;15337.079775213522;13302.600921972356;13352.465901363837;13403;13475.663108422368;13725.107867988549;14463.349149288097;14578;14785;14828.44301348343;14991.400343986119;10790.460476976277;10841.18691098155;10890.128789696964;10920.78158436811;10967.067799236835;14433.061850979653;14524.854751452773;14553.854461455674;14573;14634.780478293047 05:53:25 INFO - PID 5055 | |3;mootools.html;1343.1471015904901;1364.7338768940053;1392.1160063359764;1393.8884889208862;1395.5185461015947;11799.233049851753;12256.142070055099;12370.752584948295;12446.253224806507;12523.686907827308;12331.260124392542;12368.752624947496;12479.188852724566;12487.125901186897;12565.560205392812;2417.202323233333;2441.59713647248;2446.3272600034957;2451.44842410458;2456.336789066951;2376.702912135983;2426.842255253403;2430.6597076409316;2434.379233295507;2437.244454219189;2335.544568809083;2366.538524987628;2366.6095094309503;2384.308550520347;2389.844660097097;2286.691296674961;2324.1865347128455;2332.6617640442128;2339.1345202275097;2347.072906202049;2345.1791872844537;2346.0967527501866;2349.9412514687097;2364.219807463533;2448.755124487555;11894.810518948036;11959.641210763692;11972.281663100155;11979.700507487296;11985.041196704242;6481;6756.0879281297375;6764.594124352555;6785.525013249075;6792.117024786746;3678.1907980244305;3757.830897609614;3830.4445855351096;3863.768173909574;3900.1224724436775;1393.9860601393957;1405.9507917222847;1423.3808293392408;1435.7846323051522;1442.3004842651305;17014.744778828328;18444.63110737791;18682.81317186824;18860.339888103852;18876.339328123588;5616.129499927518;5648.378678345379;5728.971355143198;5744.684042377709;5768.250127483484;14048.789268160986;14075.507357242448;14084.154950702785;14090.52049534784;14118.364673589713;6761.8647627047185;6793.93206067933;6816.829579260459;6826.351496607815;6834.350736680008;6294.181756371642;6351.555391122577;6362.618242905441;6404.071409645575;6454.612723236621;4393.692441529126;4409.977950110229;4427.667924905645;4450.310201918708;4496.7301961882395;1306.288073000217;1317.268915751767;1324.543032653733;1330.6141219046563;1339.6048165791115;848.868425394065;871.5990644303691;871.6382701179067;880.7269746378643;903.5978989349808;6235.438810507076;6313.831985359252;6375.203099612549;6562.934370656328;6612.900806487906;643.3630705601421;660.1352228580574;660.2931422273477;661.6856992928417;664.2294937872045;4297.09760950204;4378.08060307339;4404.4494438195225;4415.072834704683;4554.772261386917;15801.525954221392;16345;16417.753733694004;16463.423780167635;16469.423570175226;15215.543533694006;15217.543473695807;15279.92360038215;15287.312070956834;15316.310766015557;9170.08299170091;9357.672481463116;9883.7034888952;10008.199344052458;10102.646407375707;7009.439244860501;7242.203357630762;7266.1280646322775;7408.148062972827;7446.292602202782;14826.77759833625;14839.406423743361;14899;14924.62688432798;15092.39630414771;14971.877109216635;15068.246587670354;15086.924565377103;15159.924200379368;15254.389824407343;10007.499625018574;10054.597816087275;10187.847182292124;10210.897891020995;10377.896221037692;11584.768304634028;11703.473343699383;11734.354610496504;11752.353620550952;11761.588344407905;9455.952720236355;9845.556949937127;9846.507674616383;10035.397876127456;10195.235357348376;9218.631254750004;9273.3045021625;9756.268279878896;9903.752406189902;9967.900320996987;8040;8137.023557173177;8151.184881511801;8233.752987410388;8238.711645092393;6336.053859445563;6396.616203027833;6525.2822189558165;6606.735730570916;6653.334666533308;6386.233651961795;6458.709358078804;6498.610083394822;6534.575252608565;6813.693383797642 05:53:25 INFO - PID 5055 | |4;prototype.html;414.55021301887456;420.35475545038355;423.44951562968134;426.9935950960736;428.01556420233464;6132.908006379907;6158.969205153973;6163.5345861655305;6177.351378105302;6193;5850.385709500505;6020.488258498033;6023.819285421444;6039.245094363205;6045.6674882881425;4630.745309008012;4667.789949452266;4679.204535229002;4700.412448443944;4700.694454860441;4663.93004104937;4673.3223682566;4687.554682305175;4703.670743047988;4724.5984091352275;4614.215583350821;4631.212693842055;4644.814207431716;4668.649851261152;4675.675000624426;4668.206404911173;4692.976535117336;4700.788464519105;4701.717896926195;4704.811807527695;4155.854545090907;4164.7709375984305;4165.208610364051;4168;4182.937255941133;5968.7015649217365;6009.188759517497;6024.770834791156;6035.3402814226;6064.727087281083;5543.25166102575;5548.833534993957;5550.500454959033;5563.471470210324;5568.248286481314;6475.963845784699;6480.222373315185;6493.512986525982;6497;6512.902306465407;4650.232711602582;4686.484486706459;4686.85980393134;4692.460367057798;4698.261643192007;6374;6764.729410823561;6784.3554862288;6830.658467076626;6841.828954276133;4718.7168769873915;4785.114753770494;4789.137955168103;4799.856004319876;4800.687955282895;4827.589654879374;4838.564529192389;4839.661223714306;4848.539388758133;4866;5367.731613419313;5480.314960629921;5501;5513.283273174462;5517.641353312102;6444.162258906312;6477.417032467007;6496.57772244812;6499.447546958561;6510.18622672166;1657.1357223123985;1672.6654669066236;1676.9580760481085;1677.2033284190156;1679.7312430011139;1105.5688281570194;1140.6920131564432;1157;1157.2362240920952;1158.6270269730396;6115.449609535163;6148.569600128038;6158.7228574714245;6172.135900973867;6248.4376406123665;6600.141981542465;6618.966905165444;6633.1376920999965;6636.336366363422;6676.532642714963;6174.722137503823;6175.456135966008;6182.783602573888;6200.41889318221;6201.844953876189;3485.634008429129;3513.3851575974104;3526.3828829954655;3539.2213712983103;3551.8756843510355;6848.280930502226;6868.278830722802;6907.481938854606;6933.895991560131;6937.549059311129;6788.864222715617;6796.694148763318;6825.215100263533;6848.315168483112;6879.972811962721;6867;6889.689963951734;6931.514793964475;6957.8956315655305;6967.895481567781;6569.967150164219;6681.966590167018;6683.7660681875905;6686;6698.162729658793;6609.570377925419;6635.369639884203;6644.242639304634;6645.501587381063;6663.433608143362;6544.214694236722;6841.384275415037;6863.279355667583;6915.723371065303;6937.132858392701;4710.26990816424;4740.834070807505;4746.952530474651;4753.405824271966;4761.23820188782;6485.481161506974;6679.632620205935;6705.865882682417;6714.683434215188;6729.629870356982;6485.708143133476;6546.003468942018;6573.276939536743;6573.539852210491;6583.604983700993;6510.967445162744;6513.641749703812;6515.208317712667;6528.934710653023;6564.868702626016;6489.805305840832;6533.575317604341;6541.901871472027;6558.868822623616;6567.44176744982;6547.345265473415;6558;6566.310537393696;6576.671166441563;6589.505787065893;6319.3364696706185;6319.96840015797;6324.873502530016;6384.329645387167;6391.174663129307 05:53:25 INFO - PID 5055 | |5;yui.html;811.1928631012144;834.4784509681448;838.4047326398253;850.6384786465751;856.5203486047811;16620.50138495844;17024.31902723891;17185.57036074097;17743.64512709745;18284.817151828513;18404.35584754534;18511.722324165148;18683.813161868376;18700.812991870076;18726.344577939773;912.1835956818643;953.1802649721234;957.2294303086013;957.8084383123369;961.4519723757461;971.0144203633317;981.9656312029081;1005.0803514783964;1010.6260683547061;1021.3718563083687;1045.639254457211;1048.7483004079043;1049.1868801678684;1049.2340591368306;1050.2910535388621;1037.9740506487399;1038.85456036155;1042.5673345561584;1046.1055797293318;1048.916086713061;767.2787579675088;767.4627760567626;769.61134627013;771.8340556780263;772.3820943245381;17173;17242.482725518254;17456.65086698259;17492.47522574325;18294.634107317914;18754.906225468785;18882.3391181308;19142.904285478482;19149.04254787269;19183.520411989673;15070.924645376703;15318.234088295541;15322.616934576614;15344.309506072253;15347.462838800588;3404.9489257661153;3421.9144521386916;3450.2064525159103;3482.2687235680537;3489.5114683944266;119610;120098.3995080019;120513.39743301315;121832;123645;14201.85798142026;14294.285285735672;14641.194734289504;14703.264836758119;14751.704965900622;26421.867890660425;26967.460650786874;27360;28230.294242643686;28542.42915141727;8222.301104406073;8480.618372173267;8666.523341216294;8715.91284087151;8788.296936245086;3833.674137698271;3906.980465097656;3907.081835768592;3932.0366510204612;3944.447777311179;4328.696991210585;4429.446319210098;4467.776611169428;4488.214562451558;4497.415336006364;822.1696086952221;833.0503226321998;838.4759525296689;841.1882533355341;842.8819965204876;708.0865683268526;728.803223129752;736.072548588782;736.5580651608992;743.6616339565485;12202.511899524097;12438.937805310916;13190.670233244246;13198.340082995812;14059.929700351433;713.5433322673493;715.47770127807;725.4559080689482;738.5015114797491;739.3198257602911;5607.327120745536;5858.794942177004;5886.646801191942;5971.970140149271;6124.173236613089;118499;119791.40104299423;120141.39929300472;121260;121855;89260;90039;104743.47628261962;108002;108824.45587772169;76693.23306766973;76787.61606191934;77785;79187;81327.59336203281;12810.487580497049;12823.422945967268;12921.806172907602;13017.414216360097;13448.596542103753;35835.64164358323;37018.8149059253;37632.81183594064;38360.80819595884;38615;48636.27045594389;49424.75287623539;49906.500934991636;50006.249906250705;71648.64175679088;18405.263789448272;18722.43832684967;18859.434216973514;18950;18981.810181898556;20803.1678732849;21580.89209553942;21649.675254870876;21900.78099219051;21901.780982190612;18844.702177118674;19254.903725481843;19636.116374763456;19736.30922917691;20044.69932950978;18527.351542695942;18592;18635;18837.210465005803;19095.140718667415;17918.104094795468;18469.168887400367;18745.718814217526;19489.220431182595;19542.120604573112;12388.318642474751;13537.1200871943;13769.518066867611;14006.929965350108;14623.19572423527;14614.853851461774;15625;15704.685906282039;15784.21078946071;15941.760873587138 05:53:25 INFO - PID 5055 | __end_tp_report 05:53:25 INFO - PID 5055 | __start_cc_report 05:53:25 INFO - PID 5055 | _x_x_mozilla_cycle_collect,338 05:53:25 INFO - PID 5055 | __end_cc_report 05:53:25 INFO - PID 5055 | __startTimestamp1496840005148__endTimestamp 05:53:25 INFO - PID 5055 | 05:53:25 INFO - PID 5055 | ------- Summary: start ------- 05:53:25 INFO - PID 5055 | Number of tests: 6 05:53:25 INFO - PID 5055 | 05:53:25 INFO - PID 5055 | [#0] dojo.html Cycles:165 Average:6019.71 Median:6313.08 stddev:739.54 (11.7%) stddev-sans-first:712.28 05:53:25 INFO - PID 5055 | Values: 3382.5 3403.4 3417.5 3418.6 3420.5 5904.1 5962.2 5966.5 6013.0 6032.4 5954.9 5986.9 5995.0 6036.0 6107.2 4958.8 5208.4 5282.0 5301.5 5369.2 5382.1 5442.2 5443.8 5446.9 5453.6 5280.4 5311.5 5350.6 5394.0 5429.6 5445.8 5446.6 5447.0 5450.1 5466.8 5402.5 5421.0 5431.6 5433.0 5441.9 5879.7 5959.3 5984.6 6009.1 6036.8 6442.7 6492.4 6503.2 6510.5 6510.7 6493.9 6516.2 6550.0 6562.5 6577.0 6013.3 6014.5 6036.7 6097.1 6104.1 6691.7 6704.9 6719.5 6724.7 6764.1 6173.6 6201.8 6308.1 6437.5 6446.5 6490.6 6572.2 6574.7 6579.0 6592.1 6353.8 6396.2 6514.9 6556.7 6567.1 6474.4 6489.6 6496.6 6504.6 6553.7 4955.3 4970.4 4970.6 4973.4 4975.2 4365.5 4365.9 4382.6 4389.2 4415.1 5900.2 5969.2 6104.3 6129.7 6139.7 6601.5 6634.4 6637.1 6637.6 6637.7 6159.6 6160.7 6171.2 6177.0 6187.3 5438.2 5451.7 5480.2 5502.2 5532.9 6759.9 6787.6 6800.2 6817.6 6829.1 6564.6 6614.2 6625.6 6628.3 6635.9 6565.5 6681.4 6791.8 6827.3 6829.9 6358.0 6377.1 6402.8 6407.7 6433.0 6677.8 6682.3 6691.4 6692.4 6698.2 6261.2 6278.4 6305.2 6371.9 6446.3 6365.6 6387.3 6392.1 6393.6 6406.7 6345.8 6379.3 6390.6 6391.0 6394.9 6313.1 6363.7 6371.4 6427.0 6433.6 6281.2 6315.2 6332.9 6341.2 6342.8 05:53:25 INFO - PID 5055 | 05:53:25 INFO - PID 5055 | [#1] ext.html Cycles:180 Average:38767.08 Median:35926.55 stddev:55479.77 (154.4%) stddev-sans-first:55561.95 05:53:25 INFO - PID 5055 | Values: 745.5 813.6 826.7 1100.3 1106.5 37598.0 38312.2 38314.8 38384.6 38475.8 40432.0 40943.2 41031.0 41073.4 41086.8 7118.8 7125.2 7210.1 7256.3 7367.7 7290.6 7312.6 7350.5 7368.0 7368.3 7296.5 7420.8 7423.1 7436.9 7437.1 7347.2 7350.0 7350.0 7360.1 7381.9 6955.7 7008.8 7013.5 7023.3 7025.2 37576.6 37625.0 37940.8 37946.8 37950.0 3473.6 3498.7 3516.5 3532.8 3538.1 29267.9 29497.4 29591.9 29636.6 29791.6 3694.9 3724.9 3725.8 3733.3 3736.4 153743.0 153986.0 155246.2 194035.0 195243.0 42192.8 42628.1 42646.8 42701.8 42770.4 44288.8 44399.6 44428.0 44630.8 44689.6 14939.6 15087.5 15096.3 15105.0 15126.2 12125.4 12217.1 12229.3 12230.8 12238.5 14432.0 14475.6 14518.6 14608.6 14831.2 5715.9 5888.7 5923.6 6039.5 6094.9 1037.4 1051.3 1059.3 1076.5 1096.6 24979.3 25290.0 25581.6 25594.7 25739.5 1151.3 1166.3 1192.8 1200.6 1213.2 13031.9 13667.5 13690.5 13905.5 13906.4 225271.0 227840.0 229132.0 230905.0 256941.0 54221.2 55190.0 55456.2 55491.7 55603.7 1476.2 1477.5 1491.2 1500.1 1507.7 29082.4 30471.5 30804.2 31300.0 31360.8 39892.2 51080.5 51357.2 51692.7 51907.7 227013.0 229622.0 230311.0 230878.0 231096.0 36063.6 36988.4 37429.3 37500.0 38137.8 47277.3 47676.8 47938.5 48541.3 48742.0 33904.5 34468.7 34733.7 35071.8 36143.4 34148.0 35113.5 35192.1 35522.0 35789.5 41616.0 41648.4 41726.4 41728.0 41752.0 31459.0 31958.7 32121.2 33220.0 34497.3 26560.0 28264.9 28470.7 28541.7 28725.3 05:53:25 INFO - PID 5055 | 05:53:25 INFO - PID 5055 | [#2] jquery.html Cycles:180 Average:32378.57 Median:20505.89 stddev:84693.10 (413.0%) stddev-sans-first:84896.73 05:53:25 INFO - PID 5055 | Values: 436.5 437.5 442.0 457.6 459.6 15391.5 15942.1 20570.5 21443.7 21503.5 22219.4 22751.5 22852.2 22886.2 22955.8 5587.2 5704.2 5736.8 5757.0 5775.9 5613.6 5674.9 5691.6 5695.9 5700.2 5383.8 5599.5 5626.1 5659.0 5675.5 5578.1 5601.4 5602.3 5624.5 5632.8 5106.1 5137.8 5152.5 5160.4 5161.4 25520.9 25834.1 26064.3 26104.9 26259.0 2186.9 2211.8 2217.5 2229.0 2229.5 16540.3 17319.0 17372.7 17462.4 17465.1 1991.4 2011.6 2016.3 2022.0 2033.7 118069.4 118982.0 120826.4 120999.0 121243.4 11958.9 11979.9 12413.1 12423.3 12878.7 17893.2 17898.0 18010.8 18055.5 18067.3 8985.7 9088.1 9162.0 9211.6 9256.9 8531.1 8793.6 8852.6 8903.6 8983.9 7173.9 7395.7 7984.3 8107.4 8206.5 2302.8 2307.3 2319.3 2348.0 2469.9 1016.2 1020.7 1024.8 1035.3 1036.7 19804.6 20172.4 20325.8 20441.3 20737.3 1020.8 1033.3 1054.1 1075.5 1076.5 10734.7 10974.2 11053.6 11282.8 11397.4 483778.0 500079.0 516669.4 519016.0 522612.0 98310.5 99048.0 99653.5 99662.5 100610.0 1143.1 1166.8 1186.7 1190.1 1194.4 16488.5 16652.0 16692.3 17795.5 17874.6 49095.8 49684.8 50830.2 51069.5 51710.2 63423.7 63634.0 63714.0 63878.4 64164.4 9365.8 10268.4 10619.0 10750.3 10791.1 16771.3 16774.1 16790.2 16929.5 16975.2 15026.7 15239.2 15271.3 15290.8 15337.1 13302.6 13352.5 13403.0 13475.7 13725.1 14463.3 14578.0 14785.0 14828.4 14991.4 10790.5 10841.2 10890.1 10920.8 10967.1 14433.1 14524.9 14553.9 14573.0 14634.8 05:53:25 INFO - PID 5055 | 05:53:25 INFO - PID 5055 | [#3] mootools.html Cycles:180 Average:7570.54 Median:2428.75 stddev:5002.71 (206.0%) stddev-sans-first:4994.86 05:53:25 INFO - PID 5055 | Values: 1343.1 1364.7 1392.1 1393.9 1395.5 11799.2 12256.1 12370.8 12446.3 12523.7 12331.3 12368.8 12479.2 12487.1 12565.6 2417.2 2441.6 2446.3 2451.4 2456.3 2376.7 2426.8 2430.7 2434.4 2437.2 2335.5 2366.5 2366.6 2384.3 2389.8 2286.7 2324.2 2332.7 2339.1 2347.1 2345.2 2346.1 2349.9 2364.2 2448.8 11894.8 11959.6 11972.3 11979.7 11985.0 6481.0 6756.1 6764.6 6785.5 6792.1 3678.2 3757.8 3830.4 3863.8 3900.1 1394.0 1406.0 1423.4 1435.8 1442.3 17014.7 18444.6 18682.8 18860.3 18876.3 5616.1 5648.4 5729.0 5744.7 5768.3 14048.8 14075.5 14084.2 14090.5 14118.4 6761.9 6793.9 6816.8 6826.4 6834.4 6294.2 6351.6 6362.6 6404.1 6454.6 4393.7 4410.0 4427.7 4450.3 4496.7 1306.3 1317.3 1324.5 1330.6 1339.6 848.9 871.6 871.6 880.7 903.6 6235.4 6313.8 6375.2 6562.9 6612.9 643.4 660.1 660.3 661.7 664.2 4297.1 4378.1 4404.4 4415.1 4554.8 15801.5 16345.0 16417.8 16463.4 16469.4 15215.5 15217.5 15279.9 15287.3 15316.3 9170.1 9357.7 9883.7 10008.2 10102.6 7009.4 7242.2 7266.1 7408.1 7446.3 14826.8 14839.4 14899.0 14924.6 15092.4 14971.9 15068.2 15086.9 15159.9 15254.4 10007.5 10054.6 10187.8 10210.9 10377.9 11584.8 11703.5 11734.4 11752.4 11761.6 9456.0 9845.6 9846.5 10035.4 10195.2 9218.6 9273.3 9756.3 9903.8 9967.9 8040.0 8137.0 8151.2 8233.8 8238.7 6336.1 6396.6 6525.3 6606.7 6653.3 6386.2 6458.7 6498.6 6534.6 6813.7 05:53:25 INFO - PID 5055 | 05:53:25 INFO - PID 5055 | [#4] prototype.html Cycles:180 Average:5459.79 Median:6167.84 stddev:1613.67 (26.2%) stddev-sans-first:1573.13 05:53:25 INFO - PID 5055 | Values: 414.6 420.4 423.4 427.0 428.0 6132.9 6159.0 6163.5 6177.4 6193.0 5850.4 6020.5 6023.8 6039.2 6045.7 4630.7 4667.8 4679.2 4700.4 4700.7 4663.9 4673.3 4687.6 4703.7 4724.6 4614.2 4631.2 4644.8 4668.6 4675.7 4668.2 4693.0 4700.8 4701.7 4704.8 4155.9 4164.8 4165.2 4168.0 4182.9 5968.7 6009.2 6024.8 6035.3 6064.7 5543.3 5548.8 5550.5 5563.5 5568.2 6476.0 6480.2 6493.5 6497.0 6512.9 4650.2 4686.5 4686.9 4692.5 4698.3 6374.0 6764.7 6784.4 6830.7 6841.8 4718.7 4785.1 4789.1 4799.9 4800.7 4827.6 4838.6 4839.7 4848.5 4866.0 5367.7 5480.3 5501.0 5513.3 5517.6 6444.2 6477.4 6496.6 6499.4 6510.2 1657.1 1672.7 1677.0 1677.2 1679.7 1105.6 1140.7 1157.0 1157.2 1158.6 6115.4 6148.6 6158.7 6172.1 6248.4 6600.1 6619.0 6633.1 6636.3 6676.5 6174.7 6175.5 6182.8 6200.4 6201.8 3485.6 3513.4 3526.4 3539.2 3551.9 6848.3 6868.3 6907.5 6933.9 6937.5 6788.9 6796.7 6825.2 6848.3 6880.0 6867.0 6889.7 6931.5 6957.9 6967.9 6570.0 6682.0 6683.8 6686.0 6698.2 6609.6 6635.4 6644.2 6645.5 6663.4 6544.2 6841.4 6863.3 6915.7 6937.1 4710.3 4740.8 4747.0 4753.4 4761.2 6485.5 6679.6 6705.9 6714.7 6729.6 6485.7 6546.0 6573.3 6573.5 6583.6 6511.0 6513.6 6515.2 6528.9 6564.9 6489.8 6533.6 6541.9 6558.9 6567.4 6547.3 6558.0 6566.3 6576.7 6589.5 6319.3 6320.0 6324.9 6384.3 6391.2 05:53:25 INFO - PID 5055 | 05:53:25 INFO - PID 5055 | [#5] yui.html Cycles:180 Average:23002.15 Median:19372.06 stddev:31757.61 (163.9%) stddev-sans-first:31802.99 05:53:25 INFO - PID 5055 | Values: 811.2 834.5 838.4 850.6 856.5 16620.5 17024.3 17185.6 17743.6 18284.8 18404.4 18511.7 18683.8 18700.8 18726.3 912.2 953.2 957.2 957.8 961.5 971.0 982.0 1005.1 1010.6 1021.4 1045.6 1048.7 1049.2 1049.2 1050.3 1038.0 1038.9 1042.6 1046.1 1048.9 767.3 767.5 769.6 771.8 772.4 17173.0 17242.5 17456.7 17492.5 18294.6 18754.9 18882.3 19142.9 19149.0 19183.5 15070.9 15318.2 15322.6 15344.3 15347.5 3404.9 3421.9 3450.2 3482.3 3489.5 119610.0 120098.4 120513.4 121832.0 123645.0 14201.9 14294.3 14641.2 14703.3 14751.7 26421.9 26967.5 27360.0 28230.3 28542.4 8222.3 8480.6 8666.5 8715.9 8788.3 3833.7 3907.0 3907.1 3932.0 3944.4 4328.7 4429.4 4467.8 4488.2 4497.4 822.2 833.1 838.5 841.2 842.9 708.1 728.8 736.1 736.6 743.7 12202.5 12438.9 13190.7 13198.3 14059.9 713.5 715.5 725.5 738.5 739.3 5607.3 5858.8 5886.6 5972.0 6124.2 118499.0 119791.4 120141.4 121260.0 121855.0 89260.0 90039.0 104743.5 108002.0 108824.5 76693.2 76787.6 77785.0 79187.0 81327.6 12810.5 12823.4 12921.8 13017.4 13448.6 35835.6 37018.8 37632.8 38360.8 38615.0 48636.3 49424.8 49906.5 50006.2 71648.6 18405.3 18722.4 18859.4 18950.0 18981.8 20803.2 21580.9 21649.7 21900.8 21901.8 18844.7 19254.9 19636.1 19736.3 20044.7 18527.4 18592.0 18635.0 18837.2 19095.1 17918.1 18469.2 18745.7 19489.2 19542.1 12388.3 13537.1 13769.5 14006.9 14623.2 14614.9 15625.0 15704.7 15784.2 15941.8 05:53:25 INFO - PID 5055 | -------- Summary: end -------- 05:53:25 INFO - PID 5055 | 05:53:26 INFO - TEST-INFO | 5055: exit 0 05:53:26 INFO - TEST-OK | dromaeo_css | took 1140476ms 05:53:26 INFO - TEST-START | kraken 05:53:26 INFO - operating with platform_type : linux_ 05:53:26 INFO - Initialising browser for kraken test... 05:53:26 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:48162/getInfo.html -profile /tmp/tmpN_Rpc5/profile 05:53:26 INFO - TEST-INFO | started process 5465 (/builds/slave/test/build/application/firefox/firefox http://localhost:48162/getInfo.html) 05:54:00 INFO - TEST-INFO | 5465: killed by SIGTERM 05:54:00 INFO - Browser initialized. 05:54:00 INFO - Running cycle 1/1 for kraken test... 05:54:00 INFO - TEST-INFO | started process 5677 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpN_Rpc5/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:54:11 INFO - PID 5677 | RSS: Main: 178163712 05:54:11 INFO - PID 5677 | 05:54:14 INFO - PID 5677 | Cycle 1(1): loaded http://localhost:48162/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:48162/tests/kraken/driver.html?testName=audio-beat-detection) 05:54:15 INFO - PID 5677 | RSS: Main: 182472704 05:54:15 INFO - PID 5677 | 05:54:17 INFO - PID 5677 | Cycle 1(1): loaded http://localhost:48162/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:48162/tests/kraken/driver.html?testName=audio-dft) 05:54:18 INFO - PID 5677 | RSS: Main: 181055488 05:54:18 INFO - PID 5677 | 05:54:21 INFO - PID 5677 | Cycle 1(1): loaded http://localhost:48162/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:48162/tests/kraken/driver.html?testName=audio-fft) 05:54:21 INFO - PID 5677 | RSS: Main: 176742400 05:54:21 INFO - PID 5677 | 05:54:23 INFO - PID 5677 | Cycle 1(1): loaded http://localhost:48162/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:48162/tests/kraken/driver.html?testName=audio-oscillator) 05:54:24 INFO - PID 5677 | RSS: Main: 178253824 05:54:24 INFO - PID 5677 | 05:54:26 INFO - PID 5677 | Cycle 1(1): loaded http://localhost:48162/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:48162/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:54:27 INFO - PID 5677 | RSS: Main: 177856512 05:54:27 INFO - PID 5677 | 05:54:30 INFO - PID 5677 | Cycle 1(1): loaded http://localhost:48162/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:48162/tests/kraken/driver.html?testName=imaging-darkroom) 05:54:30 INFO - PID 5677 | RSS: Main: 179605504 05:54:30 INFO - PID 5677 | 05:54:34 INFO - PID 5677 | Cycle 1(1): loaded http://localhost:48162/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:48162/tests/kraken/driver.html?testName=imaging-desaturate) 05:54:34 INFO - PID 5677 | RSS: Main: 181190656 05:54:34 INFO - PID 5677 | 05:54:37 INFO - PID 5677 | Cycle 1(1): loaded http://localhost:48162/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:48162/tests/kraken/driver.html?testName=json-parse-financial) 05:54:38 INFO - PID 5677 | RSS: Main: 180502528 05:54:38 INFO - PID 5677 | 05:54:39 INFO - PID 5677 | Cycle 1(1): loaded http://localhost:48162/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:48162/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:54:40 INFO - PID 5677 | RSS: Main: 179662848 05:54:40 INFO - PID 5677 | 05:54:42 INFO - PID 5677 | Cycle 1(1): loaded http://localhost:48162/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:48162/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:54:42 INFO - PID 5677 | RSS: Main: 179064832 05:54:42 INFO - PID 5677 | 05:54:44 INFO - PID 5677 | Cycle 1(1): loaded http://localhost:48162/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:48162/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:54:45 INFO - PID 5677 | RSS: Main: 179769344 05:54:45 INFO - PID 5677 | 05:54:48 INFO - PID 5677 | Cycle 1(1): loaded http://localhost:48162/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:48162/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:54:48 INFO - PID 5677 | RSS: Main: 178839552 05:54:48 INFO - PID 5677 | 05:54:51 INFO - PID 5677 | Cycle 1(1): loaded http://localhost:48162/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:48162/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:54:52 INFO - PID 5677 | RSS: Main: 179015680 05:54:52 INFO - PID 5677 | 05:54:53 INFO - PID 5677 | Cycle 1(1): loaded http://localhost:48162/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:48162/tests/kraken/driver.html?testName=ai-astar) 05:54:54 INFO - PID 5677 | RSS: Main: 180953088 05:54:54 INFO - PID 5677 | 05:54:54 INFO - PID 5677 | __start_tp_report 05:54:54 INFO - PID 5677 | _x_x_mozilla_page_load 05:54:54 INFO - PID 5677 | _x_x_mozilla_page_load_details 05:54:54 INFO - PID 5677 | |i|pagename|runs| 05:54:54 INFO - PID 5677 | |0;ai-astar;100;109;107;108;108;109;108;108;107;109 05:54:54 INFO - PID 5677 | |1;audio-beat-detection;142;118;120;158;117;117;116;118;142;119 05:54:54 INFO - PID 5677 | |2;audio-dft;165;165;164;164;164;164;162;165;176;165 05:54:54 INFO - PID 5677 | |3;audio-fft;73;73;73;96;73;73;73;72;93;73 05:54:54 INFO - PID 5677 | |4;audio-oscillator;84;84;109;84;82;82;93;81;81;103 05:54:54 INFO - PID 5677 | |5;imaging-gaussian-blur;113;114;113;114;114;115;113;115;114;114 05:54:54 INFO - PID 5677 | |6;imaging-darkroom;147;148;149;151;148;149;149;147;147;147 05:54:54 INFO - PID 5677 | |7;imaging-desaturate;94;95;95;94;94;95;95;96;95;94 05:54:54 INFO - PID 5677 | |8;json-parse-financial;45;47;46;48;47;51;48;50;51;48 05:54:54 INFO - PID 5677 | |9;json-stringify-tinderbox;57;56;59;57;56;56;57;60;56;57 05:54:54 INFO - PID 5677 | |10;stanford-crypto-aes;85;87;81;82;81;79;79;84;101;80 05:54:54 INFO - PID 5677 | |11;stanford-crypto-ccm;122;125;131;126;128;126;123;128;125;124 05:54:54 INFO - PID 5677 | |12;stanford-crypto-pbkdf2;182;178;180;193;178;174;174;181;171;175 05:54:54 INFO - PID 5677 | |13;stanford-crypto-sha256-iterative;64;63;66;64;63;71;64;61;63;61 05:54:54 INFO - PID 5677 | __end_tp_report 05:54:54 INFO - PID 5677 | __start_cc_report 05:54:54 INFO - PID 5677 | _x_x_mozilla_cycle_collect,892 05:54:54 INFO - PID 5677 | __end_cc_report 05:54:54 INFO - PID 5677 | __startTimestamp1496840094237__endTimestamp 05:54:54 INFO - PID 5677 | 05:54:54 INFO - PID 5677 | ------- Summary: start ------- 05:54:54 INFO - PID 5677 | Number of tests: 14 05:54:54 INFO - PID 5677 | 05:54:54 INFO - PID 5677 | [#0] ai-astar Cycles:10 Average:107.30 Median:108.00 stddev:2.67 (2.5%) stddev-sans-first:0.78 05:54:54 INFO - PID 5677 | Values: 100.0 109.0 107.0 108.0 108.0 109.0 108.0 108.0 107.0 109.0 05:54:54 INFO - PID 5677 | 05:54:54 INFO - PID 5677 | [#1] audio-beat-detection Cycles:10 Average:126.70 Median:119.50 stddev:14.93 (12.5%) stddev-sans-first:14.77 05:54:54 INFO - PID 5677 | Values: 142.0 118.0 120.0 158.0 117.0 117.0 116.0 118.0 142.0 119.0 05:54:54 INFO - PID 5677 | 05:54:54 INFO - PID 5677 | [#2] audio-dft Cycles:10 Average:165.40 Median:165.00 stddev:3.84 (2.3%) stddev-sans-first:4.07 05:54:54 INFO - PID 5677 | Values: 165.0 165.0 164.0 164.0 164.0 164.0 162.0 165.0 176.0 165.0 05:54:54 INFO - PID 5677 | 05:54:54 INFO - PID 5677 | [#3] audio-fft Cycles:10 Average:77.20 Median:73.00 stddev:9.15 (12.5%) stddev-sans-first:9.58 05:54:54 INFO - PID 5677 | Values: 73.0 73.0 73.0 96.0 73.0 73.0 73.0 72.0 93.0 73.0 05:54:54 INFO - PID 5677 | 05:54:54 INFO - PID 5677 | [#4] audio-oscillator Cycles:10 Average:88.30 Median:83.00 stddev:10.04 (12.1%) stddev-sans-first:10.53 05:54:54 INFO - PID 5677 | Values: 84.0 84.0 109.0 84.0 82.0 82.0 93.0 81.0 81.0 103.0 05:54:54 INFO - PID 5677 | 05:54:54 INFO - PID 5677 | [#5] imaging-gaussian-blur Cycles:10 Average:113.90 Median:114.00 stddev:0.74 (0.6%) stddev-sans-first:0.71 05:54:54 INFO - PID 5677 | Values: 113.0 114.0 113.0 114.0 114.0 115.0 113.0 115.0 114.0 114.0 05:54:54 INFO - PID 5677 | 05:54:54 INFO - PID 5677 | [#6] imaging-darkroom Cycles:10 Average:148.20 Median:148.50 stddev:1.32 (0.9%) stddev-sans-first:1.32 05:54:54 INFO - PID 5677 | Values: 147.0 148.0 149.0 151.0 148.0 149.0 149.0 147.0 147.0 147.0 05:54:54 INFO - PID 5677 | 05:54:54 INFO - PID 5677 | [#7] imaging-desaturate Cycles:10 Average:94.70 Median:95.00 stddev:0.67 (0.7%) stddev-sans-first:0.67 05:54:54 INFO - PID 5677 | Values: 94.0 95.0 95.0 94.0 94.0 95.0 95.0 96.0 95.0 94.0 05:54:54 INFO - PID 5677 | 05:54:54 INFO - PID 5677 | [#8] json-parse-financial Cycles:10 Average:48.10 Median:48.00 stddev:2.02 (4.2%) stddev-sans-first:1.81 05:54:54 INFO - PID 5677 | Values: 45.0 47.0 46.0 48.0 47.0 51.0 48.0 50.0 51.0 48.0 05:54:54 INFO - PID 5677 | 05:54:54 INFO - PID 5677 | [#9] json-stringify-tinderbox Cycles:10 Average:57.10 Median:57.00 stddev:1.37 (2.4%) stddev-sans-first:1.45 05:54:54 INFO - PID 5677 | Values: 57.0 56.0 59.0 57.0 56.0 56.0 57.0 60.0 56.0 57.0 05:54:54 INFO - PID 5677 | 05:54:54 INFO - PID 5677 | [#10] stanford-crypto-aes Cycles:10 Average:83.90 Median:81.50 stddev:6.56 (8.0%) stddev-sans-first:6.94 05:54:54 INFO - PID 5677 | Values: 85.0 87.0 81.0 82.0 81.0 79.0 79.0 84.0 101.0 80.0 05:54:54 INFO - PID 5677 | 05:54:54 INFO - PID 5677 | [#11] stanford-crypto-ccm Cycles:10 Average:125.80 Median:126.00 stddev:2.66 (2.1%) stddev-sans-first:2.44 05:54:54 INFO - PID 5677 | Values: 122.0 125.0 131.0 126.0 128.0 126.0 123.0 128.0 125.0 124.0 05:54:54 INFO - PID 5677 | 05:54:54 INFO - PID 5677 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:178.60 Median:179.00 stddev:6.15 (3.4%) stddev-sans-first:6.40 05:54:54 INFO - PID 5677 | Values: 182.0 178.0 180.0 193.0 178.0 174.0 174.0 181.0 171.0 175.0 05:54:54 INFO - PID 5677 | 05:54:54 INFO - PID 5677 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.00 Median:64.00 stddev:2.87 (4.5%) stddev-sans-first:3.04 05:54:54 INFO - PID 5677 | Values: 64.0 63.0 66.0 64.0 63.0 71.0 64.0 61.0 63.0 61.0 05:54:54 INFO - PID 5677 | -------- Summary: end -------- 05:54:54 INFO - PID 5677 | 05:54:55 INFO - TEST-INFO | 5677: exit 0 05:54:55 INFO - TEST-OK | kraken | took 89280ms 05:54:55 INFO - SUITE-END | took 1229s 05:54:55 INFO - Completed test suite (00:20:29) 05:54:55 INFO - javascript benchmark 05:54:55 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8026.375782333991, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3382.4926261060837, 3403.4044042292594, 3417.5044618530314, 3418.572678415198, 3420.4527275635905, 5904.143899134623, 5962.195103661004, 5966.4928481079105, 6012.969935150318, 6032.4269194426515, 5954.880902381949, 5986.850328741783, 5995.0, 6036.0, 6107.175531303273, 4958.776855041532, 5208.385300779264, 5281.970015846901, 5301.549368303679, 5369.167778994262, 5382.1119515280125, 5442.2380866678695, 5443.755031023594, 5446.91829622556, 5453.590980676465, 5280.3663560373, 5311.548518375904, 5350.625456218067, 5393.9730301348245, 5429.647072940246, 5445.782168713246, 5446.618736688433, 5446.972765136149, 5450.073487507133, 5466.808661696821, 5402.486763757437, 5421.0, 5431.592630552725, 5433.0, 5441.863953401157, 5879.706014699248, 5959.344472108108, 5984.551158663074, 6009.06859436788, 6036.758529658809, 6442.742290308382, 6492.448141907944, 6503.187101612299, 6510.479161667055, 6510.707018184145, 6493.870122597522, 6516.218053833571, 6549.967250163766, 6562.507811914078, 6576.967115164442, 6013.338532761392, 6014.51883849291, 6036.698165091728, 6097.115918191837, 6104.145419641254, 6691.732330706717, 6704.932950670431, 6719.496037797185, 6724.731010759613, 6764.120664313607, 6173.567850250529, 6201.751929922752, 6308.053791931247, 6437.485001199892, 6446.484281257488, 6490.643014634241, 6572.244191917895, 6574.671266436659, 6578.967105164444, 6592.110065141144, 6353.841153971188, 6396.168498095218, 6514.869702605922, 6556.704948277339, 6567.080608714784, 6474.352564743582, 6489.610623362613, 6496.6426846522945, 6504.609723416515, 6553.672316384257, 4955.331030310934, 4970.378702662168, 4970.602351811846, 4973.378327709036, 4975.228839529878, 4365.519792822787, 4365.9126817463475, 4382.583654552813, 4389.188000219906, 4415.139047885696, 5900.20347253124, 5969.2240008799445, 6104.328523862371, 6129.693515324216, 6139.706800529493, 6601.504887133388, 6634.369734875179, 6637.070810086591, 6637.601743895285, 6637.668116594151, 6159.599626024294, 6160.722767475474, 6171.197744293213, 6177.0, 6187.319394866561, 5438.211459338374, 5451.727413629303, 5480.232767412565, 5502.2296878437055, 5532.861678458071, 6759.898601520981, 6787.558808677519, 6800.183977922582, 6817.590944543244, 6829.112215411965, 6564.606123632598, 6614.239362473377, 6625.635590042594, 6628.337166283333, 6635.867282654416, 6565.474762018932, 6681.398674119353, 6791.762288319885, 6827.317268273133, 6829.897551536632, 6358.0, 6377.1390862233, 6402.807915762534, 6407.743690252338, 6433.035044743326, 6677.766278180435, 6682.3317668232785, 6691.364320389555, 6692.364225398579, 6698.162729658793, 6261.217347831521, 6278.372162783685, 6305.243370795534, 6371.872562548816, 6446.323136070832, 6365.61806291624, 6387.265464471645, 6392.105105285357, 6393.552451328548, 6406.743730250738, 6345.809625711236, 6379.266384365672, 6390.5526613136635, 6391.009393544008, 6394.936050639621, 6313.084602732486, 6363.681815909279, 6371.426571608577, 6427.035944608346, 6433.581817181868, 6281.246250449975, 6315.179026726496, 6332.905006425, 6341.175647165839, 6342.809715708536], "value": 5965.918026991831, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [745.500514655181, 813.5891374855697, 826.7106512720549, 1100.262823907982, 1106.4910141334985, 37598.0, 38312.23375532491, 38314.8084259579, 38384.616153838455, 38475.807620961925, 40432.0, 40943.18113637726, 41031.0, 41073.38389924153, 41086.7945660272, 7118.78643640689, 7125.180604230528, 7210.098737657793, 7256.346928776409, 7367.705291788322, 7290.635468226594, 7312.634368281565, 7350.4854660173805, 7368.042154519905, 7368.300011498899, 7296.489245752799, 7420.777376678709, 7423.1463381711255, 7436.888446673304, 7437.107547094356, 7347.1550771661405, 7349.963250183715, 7350.044494215745, 7360.07999000125, 7381.9261807382045, 6955.65221738911, 7008.789736307919, 7013.544119632259, 7023.332783385621, 7025.19210290818, 37576.62423375758, 37625.0, 37940.810295948344, 37946.81026594877, 37950.0, 3473.593194756128, 3498.6501349865066, 3516.507688923553, 3532.7527073104893, 3538.097785064818, 29267.853660731562, 29497.41005179906, 29591.852040739657, 29636.555451668242, 29791.55312670312, 3694.8891533254045, 3724.8696295629793, 3725.8137093145506, 3733.328000959826, 3736.4208547675153, 153743.0, 153986.0, 155246.22376888155, 194035.0, 195243.0, 42192.789036055234, 42628.1474370517, 42646.78676606597, 42701.786491067345, 42770.35844462336, 44288.77855610701, 44399.55600444019, 44428.0, 44630.776846115565, 44689.55310446919, 14939.626509337353, 15087.4719384821, 15096.320665570076, 15105.0, 15126.168060756763, 12125.39373031345, 12217.144799863925, 12229.327386993622, 12230.816537751942, 12238.510459581696, 14432.0, 14475.565733028026, 14518.564443066725, 14608.64523932093, 14831.18428486422, 5715.8856822864145, 5888.676122813286, 5923.644581325048, 6039.486643635252, 6094.908576371358, 1037.3568387599737, 1051.3429106808244, 1059.2638116509106, 1076.5048077884105, 1096.6326280696055, 24979.250622481355, 25290.0, 25581.616275755878, 25594.74405255961, 25739.485210296065, 1151.2746969409218, 1166.3060479014973, 1192.791261529229, 1200.6038007457519, 1213.2235369363614, 13031.869681303255, 13667.521636742666, 13690.452381904812, 13905.513307034407, 13906.40076391228, 225271.0, 227840.0, 229132.0, 230905.0, 256941.0, 54221.1866821998, 55190.0, 55456.16815747767, 55491.72254138784, 55603.721981389834, 1476.2249818844978, 1477.5124209011, 1491.209658880795, 1500.1224283793886, 1507.6984603079427, 29082.41835163327, 30471.542926855673, 30804.22989425282, 31300.0, 31360.843195783877, 39892.2021559573, 51080.48919510757, 51357.22964155615, 51692.74153629208, 51907.74046129745, 227013.0, 229622.0, 230311.0, 230878.0, 231096.0, 36063.63936360708, 36988.44517332296, 37429.251414971004, 37500.0, 38137.80931095438, 47277.29084063673, 47676.761616191696, 47938.5206147948, 48541.27188092252, 48742.0, 33904.491432628034, 34468.65531344755, 34733.65266347304, 35071.824640876635, 36143.37354818987, 34148.0, 35113.47329790004, 35192.120196994256, 35522.0, 35789.46315805317, 41616.0, 41648.375274371516, 41726.374104387854, 41728.0, 41752.0, 31459.0, 31958.68041319557, 32121.196970075936, 33220.0, 34497.31005379828, 26559.98244100048, 28264.85867570649, 28470.715292846806, 28541.714582854736, 28725.28186795347], "value": 17475.671402611264, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [436.491487417159, 437.5230998211948, 441.97348159110453, 457.6247477068804, 459.61851663119614, 15391.461298854543, 15942.123183224918, 20570.48573785656, 21443.67834482482, 21503.46241343965, 22219.44451388716, 22751.544969100607, 22852.200172993947, 22886.198983035596, 22955.770442295572, 5587.217789509472, 5704.172894930232, 5736.799212027579, 5757.021306377926, 5775.942240577582, 5613.578981576377, 5674.914876276859, 5691.630044047124, 5695.8576035599235, 5700.173474846145, 5383.81156659517, 5599.468050535193, 5626.071698169797, 5659.009673307155, 5675.489205971462, 5578.0517312056645, 5601.383847776741, 5602.327720673525, 5624.465675760796, 5632.802851900205, 5106.106431374532, 5137.768800403991, 5152.484751524855, 5160.432352441228, 5161.406438259611, 25520.87239563809, 25834.095806646867, 26064.34839129018, 26104.86947565269, 26259.0, 2186.8578542394694, 2211.8230541556636, 2217.46780772615, 2229.041512149775, 2229.498362868358, 16540.255688493926, 17319.0, 17372.65254694899, 17462.388816391493, 17465.126743662768, 1991.442396129086, 2011.5976804638985, 2016.2942969960543, 2021.9696704549444, 2033.6542787725973, 118069.40965295205, 118982.0, 120826.39586802098, 120999.0, 121243.3937830314, 11958.940205298917, 11979.940100299442, 12413.131080824256, 12423.31671758044, 12878.67803304925, 17893.19480623375, 17898.015609141363, 18010.819891801177, 18055.458336249932, 18067.277308907498, 8985.730428087169, 9088.136627020422, 9162.0, 9211.585478653342, 9256.8611470828, 8531.10423405546, 8793.560321983876, 8852.601632926533, 8903.599338029804, 8983.910160898307, 7173.92826071743, 7395.704171833174, 7984.281414672591, 8107.432479726481, 8206.466579672302, 2302.815774738017, 2307.3308740465077, 2319.2810228829117, 2347.9924664411683, 2469.901203951858, 1016.207358260558, 1020.6682828080903, 1024.8462730590322, 1035.316690983947, 1036.7200855769051, 19804.60390792205, 20172.39482815518, 20325.79674203239, 20441.284555040504, 20737.27419540309, 1020.7856350166549, 1033.2767063055742, 1054.130342467452, 1075.521392980132, 1076.5263284154946, 10734.677959661223, 10974.231803773659, 11053.557857685602, 11282.774344513064, 11397.373144476967, 483778.0, 500079.0, 516669.40253590536, 519016.0, 522612.0, 98310.50844745873, 99048.0, 99653.50173249232, 99662.5016874911, 100610.0, 1143.0798207442922, 1166.836642869999, 1186.6736647421856, 1190.077689790402, 1194.3908606610692, 16488.505344839676, 16652.0, 16692.332306707594, 17795.46613601594, 17874.5531361717, 49095.754521227165, 49684.75157624333, 50830.23754643757, 51069.489305107956, 51710.22434663558, 63423.68288158529, 63634.0, 63714.0, 63878.36121638724, 64164.35835641584, 9365.812683746422, 10268.435236062089, 10619.0, 10750.301230419998, 10791.082757965662, 16771.32914683399, 16774.0774257417, 16790.160491975108, 16929.492115236564, 16975.23611437513, 15026.6994660104, 15239.238038097828, 15271.312790924658, 15290.77063844021, 15337.079775213522, 13302.600921972356, 13352.465901363837, 13403.0, 13475.663108422368, 13725.107867988549, 14463.349149288097, 14578.0, 14785.0, 14828.44301348343, 14991.400343986119, 10790.460476976277, 10841.18691098155, 10890.128789696964, 10920.78158436811, 10967.067799236835, 14433.061850979653, 14524.854751452773, 14553.854461455674, 14573.0, 14634.780478293047], "value": 10471.334102382205, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1343.1471015904901, 1364.7338768940053, 1392.1160063359764, 1393.8884889208862, 1395.5185461015947, 11799.233049851753, 12256.142070055099, 12370.752584948295, 12446.253224806507, 12523.686907827308, 12331.260124392542, 12368.752624947496, 12479.188852724566, 12487.125901186897, 12565.560205392812, 2417.202323233333, 2441.59713647248, 2446.3272600034957, 2451.44842410458, 2456.336789066951, 2376.702912135983, 2426.842255253403, 2430.6597076409316, 2434.379233295507, 2437.244454219189, 2335.544568809083, 2366.538524987628, 2366.6095094309503, 2384.308550520347, 2389.844660097097, 2286.691296674961, 2324.1865347128455, 2332.6617640442128, 2339.1345202275097, 2347.072906202049, 2345.1791872844537, 2346.0967527501866, 2349.9412514687097, 2364.219807463533, 2448.755124487555, 11894.810518948036, 11959.641210763692, 11972.281663100155, 11979.700507487296, 11985.041196704242, 6481.0, 6756.0879281297375, 6764.594124352555, 6785.525013249075, 6792.117024786746, 3678.1907980244305, 3757.830897609614, 3830.4445855351096, 3863.768173909574, 3900.1224724436775, 1393.9860601393957, 1405.9507917222847, 1423.3808293392408, 1435.7846323051522, 1442.3004842651305, 17014.744778828328, 18444.63110737791, 18682.81317186824, 18860.339888103852, 18876.339328123588, 5616.129499927518, 5648.378678345379, 5728.971355143198, 5744.684042377709, 5768.250127483484, 14048.789268160986, 14075.507357242448, 14084.154950702785, 14090.52049534784, 14118.364673589713, 6761.8647627047185, 6793.93206067933, 6816.829579260459, 6826.351496607815, 6834.350736680008, 6294.181756371642, 6351.555391122577, 6362.618242905441, 6404.071409645575, 6454.612723236621, 4393.692441529126, 4409.977950110229, 4427.667924905645, 4450.310201918708, 4496.7301961882395, 1306.288073000217, 1317.268915751767, 1324.543032653733, 1330.6141219046563, 1339.6048165791115, 848.868425394065, 871.5990644303691, 871.6382701179067, 880.7269746378643, 903.5978989349808, 6235.438810507076, 6313.831985359252, 6375.203099612549, 6562.934370656328, 6612.900806487906, 643.3630705601421, 660.1352228580574, 660.2931422273477, 661.6856992928417, 664.2294937872045, 4297.09760950204, 4378.08060307339, 4404.4494438195225, 4415.072834704683, 4554.772261386917, 15801.525954221392, 16345.0, 16417.753733694004, 16463.423780167635, 16469.423570175226, 15215.543533694006, 15217.543473695807, 15279.92360038215, 15287.312070956834, 15316.310766015557, 9170.08299170091, 9357.672481463116, 9883.7034888952, 10008.199344052458, 10102.646407375707, 7009.439244860501, 7242.203357630762, 7266.1280646322775, 7408.148062972827, 7446.292602202782, 14826.77759833625, 14839.406423743361, 14899.0, 14924.62688432798, 15092.39630414771, 14971.877109216635, 15068.246587670354, 15086.924565377103, 15159.924200379368, 15254.389824407343, 10007.499625018574, 10054.597816087275, 10187.847182292124, 10210.897891020995, 10377.896221037692, 11584.768304634028, 11703.473343699383, 11734.354610496504, 11752.353620550952, 11761.588344407905, 9455.952720236355, 9845.556949937127, 9846.507674616383, 10035.397876127456, 10195.235357348376, 9218.631254750004, 9273.3045021625, 9756.268279878896, 9903.752406189902, 9967.900320996987, 8040.0, 8137.023557173177, 8151.184881511801, 8233.752987410388, 8238.711645092393, 6336.053859445563, 6396.616203027833, 6525.2822189558165, 6606.735730570916, 6653.334666533308, 6386.233651961795, 6458.709358078804, 6498.610083394822, 6534.575252608565, 6813.693383797642], "value": 5562.304931470144, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [414.55021301887456, 420.35475545038355, 423.44951562968134, 426.9935950960736, 428.01556420233464, 6132.908006379907, 6158.969205153973, 6163.5345861655305, 6177.351378105302, 6193.0, 5850.385709500505, 6020.488258498033, 6023.819285421444, 6039.245094363205, 6045.6674882881425, 4630.745309008012, 4667.789949452266, 4679.204535229002, 4700.412448443944, 4700.694454860441, 4663.93004104937, 4673.3223682566, 4687.554682305175, 4703.670743047988, 4724.5984091352275, 4614.215583350821, 4631.212693842055, 4644.814207431716, 4668.649851261152, 4675.675000624426, 4668.206404911173, 4692.976535117336, 4700.788464519105, 4701.717896926195, 4704.811807527695, 4155.854545090907, 4164.7709375984305, 4165.208610364051, 4168.0, 4182.937255941133, 5968.7015649217365, 6009.188759517497, 6024.770834791156, 6035.3402814226, 6064.727087281083, 5543.25166102575, 5548.833534993957, 5550.500454959033, 5563.471470210324, 5568.248286481314, 6475.963845784699, 6480.222373315185, 6493.512986525982, 6497.0, 6512.902306465407, 4650.232711602582, 4686.484486706459, 4686.85980393134, 4692.460367057798, 4698.261643192007, 6374.0, 6764.729410823561, 6784.3554862288, 6830.658467076626, 6841.828954276133, 4718.7168769873915, 4785.114753770494, 4789.137955168103, 4799.856004319876, 4800.687955282895, 4827.589654879374, 4838.564529192389, 4839.661223714306, 4848.539388758133, 4866.0, 5367.731613419313, 5480.314960629921, 5501.0, 5513.283273174462, 5517.641353312102, 6444.162258906312, 6477.417032467007, 6496.57772244812, 6499.447546958561, 6510.18622672166, 1657.1357223123985, 1672.6654669066236, 1676.9580760481085, 1677.2033284190156, 1679.7312430011139, 1105.5688281570194, 1140.6920131564432, 1157.0, 1157.2362240920952, 1158.6270269730396, 6115.449609535163, 6148.569600128038, 6158.7228574714245, 6172.135900973867, 6248.4376406123665, 6600.141981542465, 6618.966905165444, 6633.1376920999965, 6636.336366363422, 6676.532642714963, 6174.722137503823, 6175.456135966008, 6182.783602573888, 6200.41889318221, 6201.844953876189, 3485.634008429129, 3513.3851575974104, 3526.3828829954655, 3539.2213712983103, 3551.8756843510355, 6848.280930502226, 6868.278830722802, 6907.481938854606, 6933.895991560131, 6937.549059311129, 6788.864222715617, 6796.694148763318, 6825.215100263533, 6848.315168483112, 6879.972811962721, 6867.0, 6889.689963951734, 6931.514793964475, 6957.8956315655305, 6967.895481567781, 6569.967150164219, 6681.966590167018, 6683.7660681875905, 6686.0, 6698.162729658793, 6609.570377925419, 6635.369639884203, 6644.242639304634, 6645.501587381063, 6663.433608143362, 6544.214694236722, 6841.384275415037, 6863.279355667583, 6915.723371065303, 6937.132858392701, 4710.26990816424, 4740.834070807505, 4746.952530474651, 4753.405824271966, 4761.23820188782, 6485.481161506974, 6679.632620205935, 6705.865882682417, 6714.683434215188, 6729.629870356982, 6485.708143133476, 6546.003468942018, 6573.276939536743, 6573.539852210491, 6583.604983700993, 6510.967445162744, 6513.641749703812, 6515.208317712667, 6528.934710653023, 6564.868702626016, 6489.805305840832, 6533.575317604341, 6541.901871472027, 6558.868822623616, 6567.44176744982, 6547.345265473415, 6558.0, 6566.310537393696, 6576.671166441563, 6589.505787065893, 6319.3364696706185, 6319.96840015797, 6324.873502530016, 6384.329645387167, 6391.174663129307], "value": 4959.3675885554585, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [811.1928631012144, 834.4784509681448, 838.4047326398253, 850.6384786465751, 856.5203486047811, 16620.50138495844, 17024.31902723891, 17185.57036074097, 17743.64512709745, 18284.817151828513, 18404.35584754534, 18511.722324165148, 18683.813161868376, 18700.812991870076, 18726.344577939773, 912.1835956818643, 953.1802649721234, 957.2294303086013, 957.8084383123369, 961.4519723757461, 971.0144203633317, 981.9656312029081, 1005.0803514783964, 1010.6260683547061, 1021.3718563083687, 1045.639254457211, 1048.7483004079043, 1049.1868801678684, 1049.2340591368306, 1050.2910535388621, 1037.9740506487399, 1038.85456036155, 1042.5673345561584, 1046.1055797293318, 1048.916086713061, 767.2787579675088, 767.4627760567626, 769.61134627013, 771.8340556780263, 772.3820943245381, 17173.0, 17242.482725518254, 17456.65086698259, 17492.47522574325, 18294.634107317914, 18754.906225468785, 18882.3391181308, 19142.904285478482, 19149.04254787269, 19183.520411989673, 15070.924645376703, 15318.234088295541, 15322.616934576614, 15344.309506072253, 15347.462838800588, 3404.9489257661153, 3421.9144521386916, 3450.2064525159103, 3482.2687235680537, 3489.5114683944266, 119610.0, 120098.3995080019, 120513.39743301315, 121832.0, 123645.0, 14201.85798142026, 14294.285285735672, 14641.194734289504, 14703.264836758119, 14751.704965900622, 26421.867890660425, 26967.460650786874, 27360.0, 28230.294242643686, 28542.42915141727, 8222.301104406073, 8480.618372173267, 8666.523341216294, 8715.91284087151, 8788.296936245086, 3833.674137698271, 3906.980465097656, 3907.081835768592, 3932.0366510204612, 3944.447777311179, 4328.696991210585, 4429.446319210098, 4467.776611169428, 4488.214562451558, 4497.415336006364, 822.1696086952221, 833.0503226321998, 838.4759525296689, 841.1882533355341, 842.8819965204876, 708.0865683268526, 728.803223129752, 736.072548588782, 736.5580651608992, 743.6616339565485, 12202.511899524097, 12438.937805310916, 13190.670233244246, 13198.340082995812, 14059.929700351433, 713.5433322673493, 715.47770127807, 725.4559080689482, 738.5015114797491, 739.3198257602911, 5607.327120745536, 5858.794942177004, 5886.646801191942, 5971.970140149271, 6124.173236613089, 118499.0, 119791.40104299423, 120141.39929300472, 121260.0, 121855.0, 89260.0, 90039.0, 104743.47628261962, 108002.0, 108824.45587772169, 76693.23306766973, 76787.61606191934, 77785.0, 79187.0, 81327.59336203281, 12810.487580497049, 12823.422945967268, 12921.806172907602, 13017.414216360097, 13448.596542103753, 35835.64164358323, 37018.8149059253, 37632.81183594064, 38360.80819595884, 38615.0, 48636.27045594389, 49424.75287623539, 49906.500934991636, 50006.249906250705, 71648.64175679088, 18405.263789448272, 18722.43832684967, 18859.434216973514, 18950.0, 18981.810181898556, 20803.1678732849, 21580.89209553942, 21649.675254870876, 21900.78099219051, 21901.780982190612, 18844.702177118674, 19254.903725481843, 19636.116374763456, 19736.30922917691, 20044.69932950978, 18527.351542695942, 18592.0, 18635.0, 18837.210465005803, 19095.140718667415, 17918.104094795468, 18469.168887400367, 18745.718814217526, 19489.220431182595, 19542.120604573112, 12388.318642474751, 13537.1200871943, 13769.518066867611, 14006.929965350108, 14623.19572423527, 14614.853851461774, 15625.0, 15704.685906282039, 15784.21078946071, 15941.760873587138], "value": 8877.560452052508, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1479.2, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 109.0, 107.0, 108.0, 108.0, 109.0, 108.0, 108.0, 107.0, 109.0], "value": 107.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 118.0, 120.0, 158.0, 117.0, 117.0, 116.0, 118.0, 142.0, 119.0], "value": 126.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 165.0, 164.0, 164.0, 164.0, 164.0, 162.0, 165.0, 176.0, 165.0], "value": 165.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 73.0, 73.0, 96.0, 73.0, 73.0, 73.0, 72.0, 93.0, 73.0], "value": 77.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 109.0, 84.0, 82.0, 82.0, 93.0, 81.0, 81.0, 103.0], "value": 88.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 114.0, 113.0, 114.0, 114.0, 115.0, 113.0, 115.0, 114.0, 114.0], "value": 113.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 148.0, 149.0, 151.0, 148.0, 149.0, 149.0, 147.0, 147.0, 147.0], "value": 148.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 95.0, 94.0, 94.0, 95.0, 95.0, 96.0, 95.0, 94.0], "value": 94.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [45.0, 47.0, 46.0, 48.0, 47.0, 51.0, 48.0, 50.0, 51.0, 48.0], "value": 48.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 56.0, 59.0, 57.0, 56.0, 56.0, 57.0, 60.0, 56.0, 57.0], "value": 57.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 87.0, 81.0, 82.0, 81.0, 79.0, 79.0, 84.0, 101.0, 80.0], "value": 83.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [122.0, 125.0, 131.0, 126.0, 128.0, 126.0, 123.0, 128.0, 125.0, 124.0], "value": 125.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [182.0, 178.0, 180.0, 193.0, 178.0, 174.0, 174.0, 181.0, 171.0, 175.0], "value": 178.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 63.0, 66.0, 64.0, 63.0, 71.0, 64.0, 61.0, 63.0, 61.0], "value": 64.0, "unit": "score"}]}]} 05:54:55 INFO - Return code: 0 05:54:55 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:54:55 INFO - # TBPL SUCCESS # 05:54:55 INFO - Running post-action listener: _resource_record_post_action 05:54:55 INFO - [mozharness: 2017-06-07 12:54:55.599936Z] Finished run-tests step (success) 05:54:55 INFO - Running post-run listener: _resource_record_post_run 05:54:55 INFO - Total resource usage - Wall time: 1247s; CPU: 13.0%; Read bytes: 16384; Write bytes: 421597184; Read time: 128; Write time: 221564 05:54:55 INFO - TinderboxPrint: CPU usage
12.5% 05:54:55 INFO - TinderboxPrint: I/O read bytes / time
16,384 / 128 05:54:55 INFO - TinderboxPrint: I/O write bytes / time
421,597,184 / 221,564 05:54:55 INFO - TinderboxPrint: CPU idle
8,705.5 (87.5%) 05:54:55 INFO - TinderboxPrint: CPU user
1,198.0 (12.0%) 05:54:55 INFO - TinderboxPrint: Swap in / out
0 / 0 05:54:55 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 4096; Write bytes: 103231488; Read time: 12; Write time: 80216 05:54:55 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 05:54:55 INFO - run-tests - Wall time: 1230s; CPU: 13.0%; Read bytes: 8192; Write bytes: 318365696; Read time: 108; Write time: 141348 05:54:56 INFO - Running post-run listener: _upload_blobber_files 05:54:56 INFO - Blob upload gear active. 05:54:56 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:54:56 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 05:54:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:54:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:54:56 INFO - (blobuploader) - INFO - Open directory for files ... 05:54:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:54:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:54:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:54:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:54:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:54:57 INFO - (blobuploader) - INFO - Done attempting. 05:54:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:54:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:54:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:55:03 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:55:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:55:03 INFO - (blobuploader) - INFO - Done attempting. 05:55:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:55:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:55:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:55:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:55:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:55:05 INFO - (blobuploader) - INFO - Done attempting. 05:55:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 05:55:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:55:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:55:06 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 05:55:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:55:06 INFO - (blobuploader) - INFO - Done attempting. 05:55:06 INFO - (blobuploader) - INFO - Iteration through files over. 05:55:06 INFO - Return code: 0 05:55:06 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:55:06 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:55:06 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b79b99bd9c6aba71bc343fca88e28797139d022f31dae2caecc43a81fd95174b4d8d42d1b3c26c7a3d53e315d9613a7baa02c844ad79cfd8e933a271288d7046", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1c1ec998af9cb2fe9e06457536c35d4adaecc4977259a615c3f5390b682ef7a6d69cf35ffc9a302f63f56c4de867881fd812acbb2cdc167041f659aa4f232cd8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8f98408e8c4bb0c5ae6fa3f19348493d9c33f3ddc8d6722921f539b58c40eb0f39e1b99f6cd2fd6eee75f9df726e6d6a6a2dede52765f4dc8e2deaa941278155", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/efa9b82c5d4aea0cb67b9c150833330812678278f2693f4547e7e6baab6a52eb9de25563a3a723e118c1ce14528955d6cdec53204392c2a357ce848c653ec745"} 05:55:06 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:55:06 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:55:06 INFO - Contents: 05:55:06 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b79b99bd9c6aba71bc343fca88e28797139d022f31dae2caecc43a81fd95174b4d8d42d1b3c26c7a3d53e315d9613a7baa02c844ad79cfd8e933a271288d7046", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1c1ec998af9cb2fe9e06457536c35d4adaecc4977259a615c3f5390b682ef7a6d69cf35ffc9a302f63f56c4de867881fd812acbb2cdc167041f659aa4f232cd8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8f98408e8c4bb0c5ae6fa3f19348493d9c33f3ddc8d6722921f539b58c40eb0f39e1b99f6cd2fd6eee75f9df726e6d6a6a2dede52765f4dc8e2deaa941278155", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/efa9b82c5d4aea0cb67b9c150833330812678278f2693f4547e7e6baab6a52eb9de25563a3a723e118c1ce14528955d6cdec53204392c2a357ce848c653ec745"} 05:55:06 INFO - Running post-run listener: copy_logs_to_upload_dir 05:55:06 INFO - Copying logs to upload dir... 05:55:06 INFO - mkdir: /builds/slave/test/build/upload/logs 05:55:06 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1307.403589 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 47 secs) (at 2017-06-07 05:55:05.985172) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-06-07 05:55:05.988424) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1496838637.702639-1298006711 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b79b99bd9c6aba71bc343fca88e28797139d022f31dae2caecc43a81fd95174b4d8d42d1b3c26c7a3d53e315d9613a7baa02c844ad79cfd8e933a271288d7046", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1c1ec998af9cb2fe9e06457536c35d4adaecc4977259a615c3f5390b682ef7a6d69cf35ffc9a302f63f56c4de867881fd812acbb2cdc167041f659aa4f232cd8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8f98408e8c4bb0c5ae6fa3f19348493d9c33f3ddc8d6722921f539b58c40eb0f39e1b99f6cd2fd6eee75f9df726e6d6a6a2dede52765f4dc8e2deaa941278155", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/efa9b82c5d4aea0cb67b9c150833330812678278f2693f4547e7e6baab6a52eb9de25563a3a723e118c1ce14528955d6cdec53204392c2a357ce848c653ec745"} build_url:https://queue.taskcluster.net/v1/task/H4Wo3ZRMQ7iGiSIB2eANQw/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011417 build_url: 'https://queue.taskcluster.net/v1/task/H4Wo3ZRMQ7iGiSIB2eANQw/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b79b99bd9c6aba71bc343fca88e28797139d022f31dae2caecc43a81fd95174b4d8d42d1b3c26c7a3d53e315d9613a7baa02c844ad79cfd8e933a271288d7046", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1c1ec998af9cb2fe9e06457536c35d4adaecc4977259a615c3f5390b682ef7a6d69cf35ffc9a302f63f56c4de867881fd812acbb2cdc167041f659aa4f232cd8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8f98408e8c4bb0c5ae6fa3f19348493d9c33f3ddc8d6722921f539b58c40eb0f39e1b99f6cd2fd6eee75f9df726e6d6a6a2dede52765f4dc8e2deaa941278155", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/efa9b82c5d4aea0cb67b9c150833330812678278f2693f4547e7e6baab6a52eb9de25563a3a723e118c1ce14528955d6cdec53204392c2a357ce848c653ec745"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-06-07 05:55:06.012651) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-06-07 05:55:06.012976) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1496838637.702639-1298006711 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004457 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-06-07 05:55:06.095814) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-06-07 05:55:06.096199) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-06-07 05:55:06.096520) ========= ========= Total master_lag: 0.16 =========