builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-011 starttime: 1496320188.96 results: success (0) revision: 0bcea6bac1797e14b00af45cc7c368d12460ab7f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-06-01 05:29:48.960630) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-06-01 05:29:48.961426) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-06-01 05:29:48.964714) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-06-01 05:29:49.058796) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-06-01 05:29:49.059080) ========= 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=5cf47e208febbcd81da23b2e0000026f-1496314696.278331-184849942 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-06-01 05:29:49-- 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% 228M=0s 2017-06-01 05:29:49 (228 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.152808 ========= master_lag: 0.05 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-06-01 05:29:49.265552) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-06-01 05:29:49.265885) ========= 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=5cf47e208febbcd81da23b2e0000026f-1496314696.278331-184849942 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.063772 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-06-01 05:29:49.343948) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-06-01 05:29:49.344284) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 0bcea6bac1797e14b00af45cc7c368d12460ab7f --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 0bcea6bac1797e14b00af45cc7c368d12460ab7f --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=5cf47e208febbcd81da23b2e0000026f-1496314696.278331-184849942 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-06-01 05:29:49,379 truncating revision to first 12 chars 2017-06-01 05:29:49,379 Setting DEBUG logging. 2017-06-01 05:29:49,379 attempt 1/10 2017-06-01 05:29:49,379 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/0bcea6bac179?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-06-01 05:29:49,775 unpacking tar archive at: mozilla-central-0bcea6bac179/testing/mozharness/ program finished with exit code 0 elapsedTime=0.752075 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-06-01 05:29:50.111615) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-06-01 05:29:50.114956) ========= script_repo_revision: 0bcea6bac1797e14b00af45cc7c368d12460ab7f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-06-01 05:29:50.115340) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-06-01 05:29:50.115598) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-06-01 05:29:50.125006) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 1 secs) (at 2017-06-01 05:29:50.125269) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5cf47e208febbcd81da23b2e0000026f-1496314696.278331-184849942 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:29:50 INFO - MultiFileLogger online at 20170601 05:29:50 in /builds/slave/test 05:29:50 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 05:29:50 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:29:50 INFO - {'append_to_log': False, 05:29:50 INFO - 'base_work_dir': '/builds/slave/test', 05:29:50 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 05:29:50 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:29:50 INFO - 'branch': 'Firefox-Non-PGO', 05:29:50 INFO - 'buildbot_json_path': 'buildprops.json', 05:29:50 INFO - 'config_files': ('talos/linux_config.py',), 05:29:50 INFO - 'default_actions': ('clobber', 05:29:50 INFO - 'read-buildbot-config', 05:29:50 INFO - 'download-and-extract', 05:29:50 INFO - 'populate-webroot', 05:29:50 INFO - 'create-virtualenv', 05:29:50 INFO - 'install', 05:29:50 INFO - 'setup-mitmproxy', 05:29:50 INFO - 'run-tests'), 05:29:50 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:29:50 INFO - 'download_minidump_stackwalk': True, 05:29:50 INFO - 'download_symbols': 'ondemand', 05:29:50 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:29:50 INFO - 'tooltool.py': '/tools/tooltool.py', 05:29:50 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:29:50 INFO - '/tools/misc-python/virtualenv.py')}, 05:29:50 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:29:50 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:29:50 INFO - 'gecko_profile': False, 05:29:50 INFO - 'gecko_profile_interval': 0, 05:29:50 INFO - 'installer_path': 'installer.exe', 05:29:50 INFO - 'log_level': 'info', 05:29:50 INFO - 'log_name': 'talos', 05:29:50 INFO - 'log_to_console': True, 05:29:50 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:29:50 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:29:50 INFO - 'opt_config_files': (), 05:29:50 INFO - 'pip_index': False, 05:29:50 INFO - 'suite': 'dromaeojs-e10s', 05:29:50 INFO - 'system_bits': '32', 05:29:50 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:29:50 INFO - 'title': 'talos-linux64-ix-011', 05:29:50 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:29:50 INFO - 'use_talos_json': True, 05:29:50 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:29:50 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:29:50 INFO - 'work_dir': 'build'} 05:29:50 INFO - [mozharness: 2017-06-01 12:29:50.407484Z] Running clobber step. 05:29:50 INFO - Running pre-action listener: _resource_record_pre_action 05:29:50 INFO - Running main action method: clobber 05:29:50 INFO - rmtree: /builds/slave/test/build 05:29:50 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:29:52 INFO - Running post-action listener: _resource_record_post_action 05:29:52 INFO - [mozharness: 2017-06-01 12:29:52.995589Z] Finished clobber step (success) 05:29:52 INFO - [mozharness: 2017-06-01 12:29:52.995747Z] Running read-buildbot-config step. 05:29:52 INFO - Running pre-action listener: _resource_record_pre_action 05:29:52 INFO - Running main action method: read_buildbot_config 05:29:52 INFO - Using buildbot properties: 05:29:52 INFO - { 05:29:52 INFO - "project": "", 05:29:52 INFO - "product": "firefox", 05:29:52 INFO - "who": "cbook@mozilla.com", 05:29:52 INFO - "installer_path": "public/build/target.tar.bz2", 05:29:52 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 05:29:52 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 05:29:52 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 05:29:52 INFO - "stage_platform": "linux64", 05:29:52 INFO - "basedir": "/builds/slave/test", 05:29:52 INFO - "buildnumber": 877, 05:29:52 INFO - "platform": "ubuntu64_hw", 05:29:52 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 05:29:52 INFO - "slavebuilddir": "test", 05:29:52 INFO - "taskId": "Z6mTXVTTSPy-XNedeejh3A", 05:29:52 INFO - "branch": "mozilla-central", 05:29:52 INFO - "script_repo_revision": "production", 05:29:52 INFO - "revision": "0bcea6bac1797e14b00af45cc7c368d12460ab7f", 05:29:52 INFO - "slavename": "talos-linux64-ix-011", 05:29:52 INFO - "repo_path": "mozilla-central" 05:29:52 INFO - } 05:29:52 INFO - Finding installer, test and symbols from parent task. 05:29:52 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Z6mTXVTTSPy-XNedeejh3A'}, attempt #1 05:29:53 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Z6mTXVTTSPy-XNedeejh3A'}, attempt #1 05:29:53 INFO - Task dependencies: JkQc7maxRUa3Rvf0G-7tsA 05:29:53 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JkQc7maxRUa3Rvf0G-7tsA'}, attempt #1 05:29:54 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/JkQc7maxRUa3Rvf0G-7tsA/artifacts/public/build/target.tar.bz2 05:29:54 INFO - Set test_url: https://queue.taskcluster.net/v1/task/JkQc7maxRUa3Rvf0G-7tsA/artifacts/public/build/test_packages.json 05:29:54 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/JkQc7maxRUa3Rvf0G-7tsA/artifacts/public/build/target.crashreporter-symbols.zip 05:29:54 INFO - Running post-action listener: _resource_record_post_action 05:29:54 INFO - [mozharness: 2017-06-01 12:29:54.350831Z] Finished read-buildbot-config step (success) 05:29:54 INFO - [mozharness: 2017-06-01 12:29:54.351060Z] Running download-and-extract step. 05:29:54 INFO - Running pre-action listener: _resource_record_pre_action 05:29:54 INFO - Running main action method: download_and_extract 05:29:54 INFO - mkdir: /builds/slave/test/build/tests 05:29: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:29:54 INFO - trying https://queue.taskcluster.net/v1/task/JkQc7maxRUa3Rvf0G-7tsA/artifacts/public/build/target.test_packages.json 05:29:54 INFO - Downloading https://queue.taskcluster.net/v1/task/JkQc7maxRUa3Rvf0G-7tsA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 05:29:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JkQc7maxRUa3Rvf0G-7tsA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 05:29:54 INFO - Downloaded 986 bytes. 05:29:54 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 05:29:54 INFO - Using the following test package requirements: 05:29:54 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 05:29:54 INFO - u'common': [u'target.common.tests.zip'], 05:29:54 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 05:29:54 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 05:29:54 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 05:29:54 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 05:29:54 INFO - u'mozbase': [u'target.common.tests.zip'], 05:29:54 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 05:29:54 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 05:29:54 INFO - u'web-platform': [u'target.common.tests.zip', 05:29:54 INFO - u'target.web-platform.tests.zip'], 05:29:54 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 05:29:54 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 05:29:54 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/JkQc7maxRUa3Rvf0G-7tsA/artifacts/public/build/target.common.tests.zip 05:29:54 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JkQc7maxRUa3Rvf0G-7tsA/artifacts/public/build/target.common.tests.zip'}, attempt #1 05:29:54 INFO - Fetch https://queue.taskcluster.net/v1/task/JkQc7maxRUa3Rvf0G-7tsA/artifacts/public/build/target.common.tests.zip into memory 05:29:56 INFO - Content-Length response header: 63538855 05:29:56 INFO - Bytes received: 63538855 05:30:08 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 05:30:08 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/JkQc7maxRUa3Rvf0G-7tsA/artifacts/public/build/target.common.tests.zip 05:30:08 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JkQc7maxRUa3Rvf0G-7tsA/artifacts/public/build/target.common.tests.zip'}, attempt #1 05:30:08 INFO - Fetch https://queue.taskcluster.net/v1/task/JkQc7maxRUa3Rvf0G-7tsA/artifacts/public/build/target.common.tests.zip into memory 05:30:09 INFO - Content-Length response header: 63538855 05:30:09 INFO - Bytes received: 63538855 05:30:21 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/JkQc7maxRUa3Rvf0G-7tsA/artifacts/public/build/target.talos.tests.zip 05:30:21 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JkQc7maxRUa3Rvf0G-7tsA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 05:30:21 INFO - Fetch https://queue.taskcluster.net/v1/task/JkQc7maxRUa3Rvf0G-7tsA/artifacts/public/build/target.talos.tests.zip into memory 05:30:22 INFO - Content-Length response header: 14447425 05:30:22 INFO - Bytes received: 14447425 05:30:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:30:22 INFO - trying https://queue.taskcluster.net/v1/task/JkQc7maxRUa3Rvf0G-7tsA/artifacts/public/build/target.tar.bz2 05:30:22 INFO - Downloading https://queue.taskcluster.net/v1/task/JkQc7maxRUa3Rvf0G-7tsA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 05:30:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JkQc7maxRUa3Rvf0G-7tsA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 05:30:23 INFO - Downloaded 54099661 bytes. 05:30:23 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/JkQc7maxRUa3Rvf0G-7tsA/artifacts/public/build/target.tar.bz2 05:30:23 INFO - mkdir: /builds/slave/test/properties 05:30:23 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:30:23 INFO - Writing to file /builds/slave/test/properties/build_url 05:30:23 INFO - Contents: 05:30:23 INFO - build_url:https://queue.taskcluster.net/v1/task/JkQc7maxRUa3Rvf0G-7tsA/artifacts/public/build/target.tar.bz2 05:30:23 INFO - Running post-action listener: _resource_record_post_action 05:30:23 INFO - Running post-action listener: set_extra_try_arguments 05:30:23 INFO - [mozharness: 2017-06-01 12:30:23.687600Z] Finished download-and-extract step (success) 05:30:23 INFO - [mozharness: 2017-06-01 12:30:23.687698Z] Running populate-webroot step. 05:30:23 INFO - Running pre-action listener: _resource_record_pre_action 05:30:23 INFO - Running main action method: populate_webroot 05:30:23 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:30:23 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:30:23 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:30:23 INFO - '--tppagecycles', 05:30:23 INFO - '7'], 05:30:23 INFO - 'tests': ['tsvgm']}}, 05:30:23 INFO - 'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:30:23 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:30:23 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:30:23 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:30:23 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 05:30:23 INFO - 'talos_options': ['--disable-e10s'], 05:30:23 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:30:23 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 05:30:23 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:30:23 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 05:30:23 INFO - 'talos_options': ['--disable-e10s'], 05:30:23 INFO - 'tests': ['damp', 'tps']}, 05:30:23 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 05:30:23 INFO - 'tests': ['damp', 'tps']}, 05:30:23 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:30:23 INFO - 'tests': ['dromaeo_dom']}, 05:30:23 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:30:23 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:30:23 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 05:30:23 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 05:30:23 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 05:30:23 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 05:30:23 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:30:23 INFO - 'tests': ['a11yr', 05:30:23 INFO - 'ts_paint', 05:30:23 INFO - 'tpaint', 05:30:23 INFO - 'sessionrestore', 05:30:23 INFO - 'sessionrestore_no_auto_restore', 05:30:23 INFO - 'tabpaint']}, 05:30:23 INFO - 'other-e10s': {'tests': ['a11yr', 05:30:23 INFO - 'ts_paint', 05:30:23 INFO - 'tpaint', 05:30:23 INFO - 'sessionrestore', 05:30:23 INFO - 'sessionrestore_no_auto_restore', 05:30:23 INFO - 'tabpaint']}, 05:30:23 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:30:23 INFO - 'ts_paint', 05:30:23 INFO - 'tpaint', 05:30:23 INFO - 'sessionrestore', 05:30:23 INFO - 'sessionrestore_no_auto_restore', 05:30:23 INFO - 'tabpaint']}, 05:30:23 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:30:23 INFO - 'ts_paint', 05:30:23 INFO - 'tpaint', 05:30:23 INFO - 'sessionrestore', 05:30:23 INFO - 'sessionrestore_no_auto_restore', 05:30:23 INFO - 'tabpaint']}, 05:30:23 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:30:23 INFO - 'tests': ['a11yr', 05:30:23 INFO - 'ts_paint', 05:30:23 INFO - 'tpaint', 05:30:23 INFO - 'sessionrestore', 05:30:23 INFO - 'sessionrestore_no_auto_restore', 05:30:23 INFO - 'tabpaint']}, 05:30:23 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:30:23 INFO - 'tests': ['a11yr', 05:30:23 INFO - 'ts_paint', 05:30:23 INFO - 'tpaint', 05:30:23 INFO - 'sessionrestore', 05:30:23 INFO - 'sessionrestore_no_auto_restore', 05:30:23 INFO - 'tabpaint']}, 05:30:23 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 05:30:23 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 05:30:23 INFO - 'bloom_basic_ref']}, 05:30:23 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set.zip', 05:30:23 INFO - 'talos_options': ['--mitmproxy', 05:30:23 INFO - 'mitmproxy-recording-1.mp', 05:30:23 INFO - '--firstNonBlankPaint'], 05:30:23 INFO - 'tests': ['Quantum_1']}, 05:30:23 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:30:23 INFO - 'tests': ['tsvgx', 05:30:23 INFO - 'tsvgr_opacity', 05:30:23 INFO - 'tart', 05:30:23 INFO - 'tscrollx', 05:30:23 INFO - 'cart', 05:30:23 INFO - 'tsvg_static']}, 05:30:23 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:30:23 INFO - 'tsvgr_opacity', 05:30:23 INFO - 'tart', 05:30:23 INFO - 'tscrollx', 05:30:23 INFO - 'cart', 05:30:23 INFO - 'tsvg_static']}, 05:30:23 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 05:30:23 INFO - 'talos_options': ['--disable-e10s'], 05:30:23 INFO - 'tests': ['tp5o']}, 05:30:23 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 05:30:23 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 05:30:23 INFO - 'talos_options': ['--disable-e10s', 05:30:23 INFO - '--xperf_path', 05:30:23 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:30:23 INFO - 'tests': ['tp5n']}, 05:30:23 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 05:30:23 INFO - 'talos_options': ['--xperf_path', 05:30:23 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:30:23 INFO - 'tests': ['tp5n']}}, 05:30:23 INFO - 'talos.zip': {'path': '', 05:30:23 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:30:23 INFO - Running post-action listener: _resource_record_post_action 05:30:23 INFO - [mozharness: 2017-06-01 12:30:23.705291Z] Finished populate-webroot step (success) 05:30:23 INFO - [mozharness: 2017-06-01 12:30:23.705385Z] Running create-virtualenv step. 05:30:23 INFO - Running pre-action listener: _resource_record_pre_action 05:30:23 INFO - Running main action method: create_virtualenv 05:30:23 INFO - Creating virtualenv /builds/slave/test/build/venv 05:30:23 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:30:23 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:30:23 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 05:30:23 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:30:23 INFO - Using real prefix '/usr' 05:30:23 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:30:24 INFO - Installing distribute.............................................................................................................................................................................................done. 05:30:26 INFO - Installing pip.................done. 05:30:26 INFO - Return code: 0 05:30:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 05:30:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 05:30:26 INFO - Reading from file tmpfile_stdout 05:30:26 INFO - Output received: 05:30:26 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:30:26 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:30:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:30:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:30:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:30:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:30:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c6f3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e49a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1feddd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fea840>, '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 0x1feb740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1febbd0>, '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': '5cf47e208febbcd81da23b2e0000026f-1496314696.278331-184849942', '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:30:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 05:30:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:30:26 INFO - Using env: {'DISPLAY': ':0', 05:30:26 INFO - 'HOME': '/home/cltbld', 05:30:26 INFO - 'LANG': 'en_US.UTF-8', 05:30:26 INFO - 'LANGUAGE': 'en_US:en', 05:30:26 INFO - 'LOGNAME': 'cltbld', 05:30:26 INFO - 'MAIL': '/var/mail/cltbld', 05:30:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:30:26 INFO - 'MOZ_NO_REMOTE': '1', 05:30:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:30:26 INFO - 'NO_EM_RESTART': '1', 05:30:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:30:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:30:26 INFO - 'PWD': '/builds/slave/test', 05:30:26 INFO - 'SHELL': '/bin/bash', 05:30:26 INFO - 'SHLVL': '1', 05:30:26 INFO - 'TERM': 'linux', 05:30:26 INFO - 'TMOUT': '86400', 05:30:26 INFO - 'USER': 'cltbld', 05:30:26 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1496314696.278331-184849942', 05:30:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:30:26 INFO - '_': '/tools/buildbot/bin/python'} 05:30:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:30:27 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:30:27 INFO - Cleaning up... 05:30:27 INFO - Return code: 0 05:30:27 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:30:27 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:30:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:30:27 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:30:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:30:27 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 0x1c6f3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e49a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1feddd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fea840>, '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 0x1feb740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1febbd0>, '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': '5cf47e208febbcd81da23b2e0000026f-1496314696.278331-184849942', '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:30:27 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:30:27 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:30:27 INFO - Using env: {'DISPLAY': ':0', 05:30:27 INFO - 'HOME': '/home/cltbld', 05:30:27 INFO - 'LANG': 'en_US.UTF-8', 05:30:27 INFO - 'LANGUAGE': 'en_US:en', 05:30:27 INFO - 'LOGNAME': 'cltbld', 05:30:27 INFO - 'MAIL': '/var/mail/cltbld', 05:30:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:30:27 INFO - 'MOZ_NO_REMOTE': '1', 05:30:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:30:27 INFO - 'NO_EM_RESTART': '1', 05:30:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:30:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:30:27 INFO - 'PWD': '/builds/slave/test', 05:30:27 INFO - 'SHELL': '/bin/bash', 05:30:27 INFO - 'SHLVL': '1', 05:30:27 INFO - 'TERM': 'linux', 05:30:27 INFO - 'TMOUT': '86400', 05:30:27 INFO - 'USER': 'cltbld', 05:30:27 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1496314696.278331-184849942', 05:30:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:30:27 INFO - '_': '/tools/buildbot/bin/python'} 05:30:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:30:27 INFO - Downloading/unpacking psutil>=3.1.1 05:30:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:30:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:30:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:30:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:30:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:30:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:30:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:30:28 INFO - Installing collected packages: psutil 05:30:28 INFO - Running setup.py install for psutil 05:30:28 INFO - building 'psutil._psutil_linux' extension 05:30:28 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:30:29 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:30:29 INFO - building 'psutil._psutil_posix' extension 05:30:29 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:30:29 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:30:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:30:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:30:30 INFO - Successfully installed psutil 05:30:30 INFO - Cleaning up... 05:30:30 INFO - Return code: 0 05:30:30 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:30:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:30:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:30:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:30:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:30:30 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 0x1c6f3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e49a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1feddd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fea840>, '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 0x1feb740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1febbd0>, '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': '5cf47e208febbcd81da23b2e0000026f-1496314696.278331-184849942', '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:30:30 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:30:30 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:30:30 INFO - Using env: {'DISPLAY': ':0', 05:30:30 INFO - 'HOME': '/home/cltbld', 05:30:30 INFO - 'LANG': 'en_US.UTF-8', 05:30:30 INFO - 'LANGUAGE': 'en_US:en', 05:30:30 INFO - 'LOGNAME': 'cltbld', 05:30:30 INFO - 'MAIL': '/var/mail/cltbld', 05:30:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:30:30 INFO - 'MOZ_NO_REMOTE': '1', 05:30:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:30:30 INFO - 'NO_EM_RESTART': '1', 05:30:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:30:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:30:30 INFO - 'PWD': '/builds/slave/test', 05:30:30 INFO - 'SHELL': '/bin/bash', 05:30:30 INFO - 'SHLVL': '1', 05:30:30 INFO - 'TERM': 'linux', 05:30:30 INFO - 'TMOUT': '86400', 05:30:30 INFO - 'USER': 'cltbld', 05:30:30 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1496314696.278331-184849942', 05:30:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:30:30 INFO - '_': '/tools/buildbot/bin/python'} 05:30:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:30:30 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:30:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:30:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:30:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:30:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:30:31 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:30:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:30:31 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:30:31 INFO - Installing collected packages: mozsystemmonitor 05:30:31 INFO - Running setup.py install for mozsystemmonitor 05:30:31 INFO - Successfully installed mozsystemmonitor 05:30:31 INFO - Cleaning up... 05:30:31 INFO - Return code: 0 05:30:31 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:30:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:30:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:30:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:30:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:30:31 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 0x1c6f3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e49a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1feddd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fea840>, '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 0x1feb740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1febbd0>, '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': '5cf47e208febbcd81da23b2e0000026f-1496314696.278331-184849942', '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:30:31 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:30:31 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:30:31 INFO - Using env: {'DISPLAY': ':0', 05:30:31 INFO - 'HOME': '/home/cltbld', 05:30:31 INFO - 'LANG': 'en_US.UTF-8', 05:30:31 INFO - 'LANGUAGE': 'en_US:en', 05:30:31 INFO - 'LOGNAME': 'cltbld', 05:30:31 INFO - 'MAIL': '/var/mail/cltbld', 05:30:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:30:31 INFO - 'MOZ_NO_REMOTE': '1', 05:30:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:30:31 INFO - 'NO_EM_RESTART': '1', 05:30:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:30:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:30:31 INFO - 'PWD': '/builds/slave/test', 05:30:31 INFO - 'SHELL': '/bin/bash', 05:30:31 INFO - 'SHLVL': '1', 05:30:31 INFO - 'TERM': 'linux', 05:30:31 INFO - 'TMOUT': '86400', 05:30:31 INFO - 'USER': 'cltbld', 05:30:31 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1496314696.278331-184849942', 05:30:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:30:31 INFO - '_': '/tools/buildbot/bin/python'} 05:30:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:30:31 INFO - Downloading/unpacking jsonschema==2.5.1 05:30:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:30:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:30:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:30:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:30:32 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:30:32 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:30:32 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:30:32 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:30:32 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:30:32 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:30:33 INFO - Downloading functools32-3.2.3-2.tar.gz 05:30:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:30:33 INFO - warning: no files found matching '*.txt' 05:30:33 INFO - no previously-included directories found matching 'build' 05:30:33 INFO - no previously-included directories found matching 'dist' 05:30:33 INFO - no previously-included directories found matching '.git*' 05:30:33 INFO - Installing collected packages: jsonschema, functools32 05:30:33 INFO - Running setup.py install for functools32 05:30:33 INFO - warning: no files found matching '*.txt' 05:30:33 INFO - no previously-included directories found matching 'build' 05:30:33 INFO - no previously-included directories found matching 'dist' 05:30:33 INFO - no previously-included directories found matching '.git*' 05:30:33 INFO - Successfully installed jsonschema functools32 05:30:33 INFO - Cleaning up... 05:30:33 INFO - Return code: 0 05:30:33 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:30:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:30:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:30:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:30:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:30:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1c6f3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e49a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1feddd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fea840>, '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 0x1feb740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1febbd0>, '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': '5cf47e208febbcd81da23b2e0000026f-1496314696.278331-184849942', '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:30:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 05:30:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 05:30:33 INFO - Using env: {'DISPLAY': ':0', 05:30:33 INFO - 'HOME': '/home/cltbld', 05:30:33 INFO - 'LANG': 'en_US.UTF-8', 05:30:33 INFO - 'LANGUAGE': 'en_US:en', 05:30:33 INFO - 'LOGNAME': 'cltbld', 05:30:33 INFO - 'MAIL': '/var/mail/cltbld', 05:30:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:30:33 INFO - 'MOZ_NO_REMOTE': '1', 05:30:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:30:33 INFO - 'NO_EM_RESTART': '1', 05:30:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:30:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:30:33 INFO - 'PWD': '/builds/slave/test', 05:30:33 INFO - 'SHELL': '/bin/bash', 05:30:33 INFO - 'SHLVL': '1', 05:30:33 INFO - 'TERM': 'linux', 05:30:33 INFO - 'TMOUT': '86400', 05:30:33 INFO - 'USER': 'cltbld', 05:30:33 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1496314696.278331-184849942', 05:30:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:30:33 INFO - '_': '/tools/buildbot/bin/python'} 05:30:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:30:33 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:30:33 INFO - Cleaning up... 05:30:33 INFO - Return code: 0 05:30:33 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:30:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:30:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:30:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:30:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:30:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1c6f3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e49a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1feddd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fea840>, '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 0x1feb740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1febbd0>, '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': '5cf47e208febbcd81da23b2e0000026f-1496314696.278331-184849942', '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:30:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:30:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:30:33 INFO - Using env: {'DISPLAY': ':0', 05:30:33 INFO - 'HOME': '/home/cltbld', 05:30:33 INFO - 'LANG': 'en_US.UTF-8', 05:30:33 INFO - 'LANGUAGE': 'en_US:en', 05:30:33 INFO - 'LOGNAME': 'cltbld', 05:30:33 INFO - 'MAIL': '/var/mail/cltbld', 05:30:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:30:33 INFO - 'MOZ_NO_REMOTE': '1', 05:30:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:30:33 INFO - 'NO_EM_RESTART': '1', 05:30:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:30:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:30:33 INFO - 'PWD': '/builds/slave/test', 05:30:33 INFO - 'SHELL': '/bin/bash', 05:30:33 INFO - 'SHLVL': '1', 05:30:33 INFO - 'TERM': 'linux', 05:30:33 INFO - 'TMOUT': '86400', 05:30:33 INFO - 'USER': 'cltbld', 05:30:33 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1496314696.278331-184849942', 05:30:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:30:33 INFO - '_': '/tools/buildbot/bin/python'} 05:30:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:30:33 INFO - Downloading/unpacking blobuploader==1.2.4 05:30:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:30:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:30:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:30:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:30:35 INFO - Downloading blobuploader-1.2.4.tar.gz 05:30:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:30:35 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:30:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:30:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:30:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:30:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:30:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:30:36 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:30:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:30:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:30:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:30:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:30:36 INFO - Downloading docopt-0.6.1.tar.gz 05:30:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:30:36 INFO - Installing collected packages: blobuploader, requests, docopt 05:30:36 INFO - Running setup.py install for blobuploader 05:30:36 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:30:36 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:30:36 INFO - Running setup.py install for requests 05:30:36 INFO - Running setup.py install for docopt 05:30:36 INFO - Successfully installed blobuploader requests docopt 05:30:36 INFO - Cleaning up... 05:30:37 INFO - Return code: 0 05:30:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:30:37 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:30:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:30:37 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:30:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:30:37 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 0x1c6f3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e49a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1feddd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fea840>, '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 0x1feb740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1febbd0>, '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': '5cf47e208febbcd81da23b2e0000026f-1496314696.278331-184849942', '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:30:37 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:30:37 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:30:37 INFO - Using env: {'DISPLAY': ':0', 05:30:37 INFO - 'HOME': '/home/cltbld', 05:30:37 INFO - 'LANG': 'en_US.UTF-8', 05:30:37 INFO - 'LANGUAGE': 'en_US:en', 05:30:37 INFO - 'LOGNAME': 'cltbld', 05:30:37 INFO - 'MAIL': '/var/mail/cltbld', 05:30:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:30:37 INFO - 'MOZ_NO_REMOTE': '1', 05:30:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:30:37 INFO - 'NO_EM_RESTART': '1', 05:30:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:30:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:30:37 INFO - 'PWD': '/builds/slave/test', 05:30:37 INFO - 'SHELL': '/bin/bash', 05:30:37 INFO - 'SHLVL': '1', 05:30:37 INFO - 'TERM': 'linux', 05:30:37 INFO - 'TMOUT': '86400', 05:30:37 INFO - 'USER': 'cltbld', 05:30:37 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1496314696.278331-184849942', 05:30:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:30:37 INFO - '_': '/tools/buildbot/bin/python'} 05:30:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:30:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:30:37 INFO - Running setup.py (path:/tmp/pip-k8AyRd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:30:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:30:37 INFO - Running setup.py (path:/tmp/pip-0dr1V3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:30:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:30:37 INFO - Running setup.py (path:/tmp/pip-tMRrgb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:30:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:30:37 INFO - Running setup.py (path:/tmp/pip-1eOeFy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:30:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:30:37 INFO - Running setup.py (path:/tmp/pip-SwJu_R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:30:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:30:37 INFO - Running setup.py (path:/tmp/pip-wb5UW8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:30:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:30:37 INFO - Running setup.py (path:/tmp/pip-OHO9It-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:30:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:30:37 INFO - Running setup.py (path:/tmp/pip-C2k46r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:30:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:30:37 INFO - Running setup.py (path:/tmp/pip-oUTgjm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:30:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:30:37 INFO - Running setup.py (path:/tmp/pip-dJ5yLP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:30:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:30:37 INFO - Running setup.py (path:/tmp/pip-f5RNO7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:30:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:30:38 INFO - Running setup.py (path:/tmp/pip-E7Dxog-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:30:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:30:38 INFO - Running setup.py (path:/tmp/pip-8L24tb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:30:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:30:38 INFO - Running setup.py (path:/tmp/pip-53SvqG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:30:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:30:38 INFO - Running setup.py (path:/tmp/pip-HvdelV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:30:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:30:38 INFO - Running setup.py (path:/tmp/pip-kfoJcO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:30:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:30:38 INFO - Running setup.py (path:/tmp/pip-epsMuS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:30:38 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:30:38 INFO - Running setup.py install for manifestparser 05:30:38 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:30:38 INFO - Running setup.py install for mozcrash 05:30:38 INFO - Running setup.py install for mozdebug 05:30:38 INFO - Running setup.py install for mozdevice 05:30:38 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:30:38 INFO - Running setup.py install for mozfile 05:30:38 INFO - Running setup.py install for mozhttpd 05:30:39 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:30:39 INFO - Running setup.py install for mozinfo 05:30:39 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:30:39 INFO - Running setup.py install for mozInstall 05:30:39 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:30:39 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:30:39 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:30:39 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:30:39 INFO - Running setup.py install for mozleak 05:30:39 INFO - Running setup.py install for mozlog 05:30:39 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:30:39 INFO - Running setup.py install for moznetwork 05:30:39 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:30:39 INFO - Running setup.py install for mozprocess 05:30:39 INFO - Running setup.py install for mozprofile 05:30:39 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:30:39 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:30:39 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:30:39 INFO - Running setup.py install for mozrunner 05:30:39 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:30:39 INFO - Running setup.py install for mozscreenshot 05:30:40 INFO - Running setup.py install for moztest 05:30:40 INFO - Running setup.py install for mozversion 05:30:40 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:30:40 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:30:40 INFO - Cleaning up... 05:30:40 INFO - Return code: 0 05:30:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:30:40 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:30:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:30:40 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:30:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:30:40 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 0x1c6f3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e49a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1feddd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fea840>, '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 0x1feb740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1febbd0>, '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': '5cf47e208febbcd81da23b2e0000026f-1496314696.278331-184849942', '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:30:40 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:30:40 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:30:40 INFO - Using env: {'DISPLAY': ':0', 05:30:40 INFO - 'HOME': '/home/cltbld', 05:30:40 INFO - 'LANG': 'en_US.UTF-8', 05:30:40 INFO - 'LANGUAGE': 'en_US:en', 05:30:40 INFO - 'LOGNAME': 'cltbld', 05:30:40 INFO - 'MAIL': '/var/mail/cltbld', 05:30:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:30:40 INFO - 'MOZ_NO_REMOTE': '1', 05:30:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:30:40 INFO - 'NO_EM_RESTART': '1', 05:30:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:30:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:30:40 INFO - 'PWD': '/builds/slave/test', 05:30:40 INFO - 'SHELL': '/bin/bash', 05:30:40 INFO - 'SHLVL': '1', 05:30:40 INFO - 'TERM': 'linux', 05:30:40 INFO - 'TMOUT': '86400', 05:30:40 INFO - 'USER': 'cltbld', 05:30:40 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1496314696.278331-184849942', 05:30:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:30:40 INFO - '_': '/tools/buildbot/bin/python'} 05:30:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:30:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:30:40 INFO - Running setup.py (path:/tmp/pip-vMBniG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:30:40 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:30:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:30:40 INFO - Running setup.py (path:/tmp/pip-5rjuA7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:30:40 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:30:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:30:40 INFO - Running setup.py (path:/tmp/pip-p93sH3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:30:40 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:30:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:30:40 INFO - Running setup.py (path:/tmp/pip-bAzmt0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:30:40 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:30:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:30:40 INFO - Running setup.py (path:/tmp/pip-Csio1h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:30:40 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:30:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:30:40 INFO - Running setup.py (path:/tmp/pip-qNPzqy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:30:40 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:30:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:30:40 INFO - Running setup.py (path:/tmp/pip-S1Gw0F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:30:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 05:30:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:30:40 INFO - Running setup.py (path:/tmp/pip-uOxGBf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:30:41 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:30:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:30:41 INFO - Running setup.py (path:/tmp/pip-zyfNTd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:30:41 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:30:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:30:41 INFO - Running setup.py (path:/tmp/pip-lH7bLk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:30:41 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:30:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:30:41 INFO - Running setup.py (path:/tmp/pip-cZqnMO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:30:41 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:30:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:30:41 INFO - Running setup.py (path:/tmp/pip-3Vqxl3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:30:41 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:30:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:30:41 INFO - Running setup.py (path:/tmp/pip-D8NC_t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:30:41 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:30:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:30:41 INFO - Running setup.py (path:/tmp/pip-K7ZO3J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:30:41 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:30:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:30:41 INFO - Running setup.py (path:/tmp/pip-7u9GT6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:30:41 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:30:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:30:41 INFO - Running setup.py (path:/tmp/pip-ljWskF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:30:41 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:30:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:30:41 INFO - Running setup.py (path:/tmp/pip-ByXy5D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:30:41 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:30:41 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:30:41 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:30:41 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:30:41 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:30:41 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:30:41 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:30:41 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:30:41 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:30:41 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:30:41 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:30:42 INFO - Downloading blessings-1.6.tar.gz 05:30:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:30:42 INFO - Installing collected packages: blessings 05:30:42 INFO - Running setup.py install for blessings 05:30:42 INFO - Successfully installed blessings 05:30:42 INFO - Cleaning up... 05:30:43 INFO - Return code: 0 05:30:43 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:30:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:30:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:30:43 INFO - Reading from file tmpfile_stdout 05:30:43 INFO - Current package versions: 05:30:43 INFO - argparse == 1.2.1 05:30:43 INFO - blessings == 1.6 05:30:43 INFO - blobuploader == 1.2.4 05:30:43 INFO - docopt == 0.6.1 05:30:43 INFO - functools32 == 3.2.3-2 05:30:43 INFO - jsonschema == 2.5.1 05:30:43 INFO - manifestparser == 1.1 05:30:43 INFO - mozInstall == 1.12 05:30:43 INFO - mozcrash == 1.0 05:30:43 INFO - mozdebug == 0.1 05:30:43 INFO - mozdevice == 0.51 05:30:43 INFO - mozfile == 1.2 05:30:43 INFO - mozhttpd == 0.7 05:30:43 INFO - mozinfo == 0.9 05:30:43 INFO - mozleak == 0.1 05:30:43 INFO - mozlog == 3.4 05:30:43 INFO - moznetwork == 0.27 05:30:43 INFO - mozprocess == 0.25 05:30:43 INFO - mozprofile == 0.28 05:30:43 INFO - mozrunner == 6.13 05:30:43 INFO - mozscreenshot == 0.1 05:30:43 INFO - mozsystemmonitor == 0.3 05:30:43 INFO - moztest == 0.8 05:30:43 INFO - mozversion == 1.4 05:30:43 INFO - psutil == 3.1.1 05:30:43 INFO - requests == 1.2.3 05:30:43 INFO - wsgiref == 0.1.2 05:30:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:30:43 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:30:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:30:43 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:30:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:30:43 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 0x1c6f3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e49a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1feddd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fea840>, '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 0x1feb740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1febbd0>, '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': '5cf47e208febbcd81da23b2e0000026f-1496314696.278331-184849942', '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:30:43 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:30:43 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:30:43 INFO - Using env: {'DISPLAY': ':0', 05:30:43 INFO - 'HOME': '/home/cltbld', 05:30:43 INFO - 'LANG': 'en_US.UTF-8', 05:30:43 INFO - 'LANGUAGE': 'en_US:en', 05:30:43 INFO - 'LOGNAME': 'cltbld', 05:30:43 INFO - 'MAIL': '/var/mail/cltbld', 05:30:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:30:43 INFO - 'MOZ_NO_REMOTE': '1', 05:30:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:30:43 INFO - 'NO_EM_RESTART': '1', 05:30:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:30:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:30:43 INFO - 'PWD': '/builds/slave/test', 05:30:43 INFO - 'SHELL': '/bin/bash', 05:30:43 INFO - 'SHLVL': '1', 05:30:43 INFO - 'TERM': 'linux', 05:30:43 INFO - 'TMOUT': '86400', 05:30:43 INFO - 'USER': 'cltbld', 05:30:43 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1496314696.278331-184849942', 05:30:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:30:43 INFO - '_': '/tools/buildbot/bin/python'} 05:30:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:30:43 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:30:43 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:30:43 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:30:43 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:30:43 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:30:43 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:30:43 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:30:43 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:30:43 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:30:43 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 05:30:43 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:30:43 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:30:43 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:30:43 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:30:44 INFO - Downloading marionette_driver-1.4.0.tar.gz 05:30:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 05:30:44 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:30:44 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:30:44 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:30:44 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:30:44 INFO - Installing collected packages: marionette-driver 05:30:44 INFO - Running setup.py install for marionette-driver 05:30:44 INFO - Successfully installed marionette-driver 05:30:44 INFO - Cleaning up... 05:30:44 INFO - Return code: 0 05:30:44 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:30:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:30:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:30:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:30:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:30:44 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 0x1c6f3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e49a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1feddd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fea840>, '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 0x1feb740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1febbd0>, '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': '5cf47e208febbcd81da23b2e0000026f-1496314696.278331-184849942', '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:30:44 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:30:44 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:30:44 INFO - Using env: {'DISPLAY': ':0', 05:30:44 INFO - 'HOME': '/home/cltbld', 05:30:44 INFO - 'LANG': 'en_US.UTF-8', 05:30:44 INFO - 'LANGUAGE': 'en_US:en', 05:30:44 INFO - 'LOGNAME': 'cltbld', 05:30:44 INFO - 'MAIL': '/var/mail/cltbld', 05:30:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:30:44 INFO - 'MOZ_NO_REMOTE': '1', 05:30:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:30:44 INFO - 'NO_EM_RESTART': '1', 05:30:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:30:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:30:44 INFO - 'PWD': '/builds/slave/test', 05:30:44 INFO - 'SHELL': '/bin/bash', 05:30:44 INFO - 'SHLVL': '1', 05:30:44 INFO - 'TERM': 'linux', 05:30:44 INFO - 'TMOUT': '86400', 05:30:44 INFO - 'USER': 'cltbld', 05:30:44 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1496314696.278331-184849942', 05:30:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:30:44 INFO - '_': '/tools/buildbot/bin/python'} 05:30:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:30:44 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:30:44 INFO - Cleaning up... 05:30:45 INFO - Return code: 0 05:30:45 INFO - Running post-action listener: _resource_record_post_action 05:30:45 INFO - Running post-action listener: _start_resource_monitoring 05:30:45 INFO - Starting resource monitoring. 05:30:45 INFO - [mozharness: 2017-06-01 12:30:45.039218Z] Finished create-virtualenv step (success) 05:30:45 INFO - [mozharness: 2017-06-01 12:30:45.040153Z] Running install step. 05:30:45 INFO - Running pre-action listener: _resource_record_pre_action 05:30:45 INFO - Running main action method: install 05:30:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:30:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:30:45 INFO - Reading from file tmpfile_stdout 05:30:45 INFO - Detecting whether we're running mozinstall >=1.0... 05:30:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:30:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:30:45 INFO - Reading from file tmpfile_stdout 05:30:45 INFO - Output received: 05:30:45 INFO - Usage: mozinstall [options] installer 05:30:45 INFO - Options: 05:30:45 INFO - -h, --help show this help message and exit 05:30:45 INFO - -d DEST, --destination=DEST 05:30:45 INFO - Directory to install application into. [default: 05:30:45 INFO - "/builds/slave/test"] 05:30:45 INFO - --app=APP Application being installed. [default: firefox] 05:30:45 INFO - mkdir: /builds/slave/test/build/application 05:30:45 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:30:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 05:31:00 INFO - Reading from file tmpfile_stdout 05:31:00 INFO - Output received: 05:31:00 INFO - /builds/slave/test/build/application/firefox/firefox 05:31:00 INFO - Running post-action listener: _resource_record_post_action 05:31:00 INFO - [mozharness: 2017-06-01 12:31:00.911226Z] Finished install step (success) 05:31:00 INFO - [mozharness: 2017-06-01 12:31:00.911477Z] Running setup-mitmproxy step. 05:31:00 INFO - Running pre-action listener: _resource_record_pre_action 05:31:00 INFO - Running main action method: setup_mitmproxy 05:31:00 INFO - Skipping: mitmproxy is not required 05:31:00 INFO - Running post-action listener: _resource_record_post_action 05:31:00 INFO - [mozharness: 2017-06-01 12:31:00.912593Z] Finished setup-mitmproxy step (success) 05:31:00 INFO - [mozharness: 2017-06-01 12:31:00.912814Z] Running run-tests step. 05:31:00 INFO - Running pre-action listener: _resource_record_pre_action 05:31:00 INFO - Running main action method: run_tests 05:31:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:31:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:31:00 INFO - Python 2.7.3 05:31:00 INFO - Return code: 0 05:31:00 INFO - grabbing minidump binary from tooltool 05:31: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:31:00 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 0x1fea840>, '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 0x1feb740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1febbd0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:31:00 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:31:00 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:31:00 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:31:01 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:31:01 INFO - Return code: 0 05:31:01 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:31:01 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:31:01 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:31:01 INFO - ENV: RUST_BACKTRACE is now 1 05:31:01 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:31:01 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:31:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JkQc7maxRUa3Rvf0G-7tsA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-011', '--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:31:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/JkQc7maxRUa3Rvf0G-7tsA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-011 --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:31:01 INFO - Using env: {'DISPLAY': ':0', 05:31:01 INFO - 'HOME': '/home/cltbld', 05:31:01 INFO - 'LANG': 'en_US.UTF-8', 05:31:01 INFO - 'LANGUAGE': 'en_US:en', 05:31:01 INFO - 'LOGNAME': 'cltbld', 05:31:01 INFO - 'MAIL': '/var/mail/cltbld', 05:31:01 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:31:01 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:31:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:31:01 INFO - 'MOZ_NO_REMOTE': '1', 05:31:01 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:31:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:31:01 INFO - 'NO_EM_RESTART': '1', 05:31:01 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:31:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:31:01 INFO - 'PWD': '/builds/slave/test', 05:31:01 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:31:01 INFO - 'RUST_BACKTRACE': '1', 05:31:01 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 05:31:01 INFO - 'SHELL': '/bin/bash', 05:31:01 INFO - 'SHLVL': '1', 05:31:01 INFO - 'TERM': 'linux', 05:31:01 INFO - 'TMOUT': '86400', 05:31:01 INFO - 'USER': 'cltbld', 05:31:01 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1496314696.278331-184849942', 05:31:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:31:01 INFO - '_': '/tools/buildbot/bin/python'} 05:31:01 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JkQc7maxRUa3Rvf0G-7tsA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-011', '--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:31:01 INFO - mozversion application_buildid: 20170601115111 05:31:01 INFO - mozversion application_changeset: 0bcea6bac1797e14b00af45cc7c368d12460ab7f 05:31:01 INFO - mozversion application_display_name: Nightly 05:31:01 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:31:01 INFO - mozversion application_name: Firefox 05:31:01 INFO - mozversion application_remotingname: firefox 05:31:01 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:31:01 INFO - mozversion application_vendor: Mozilla 05:31:01 INFO - mozversion application_version: 55.0a1 05:31:01 INFO - mozversion platform_buildid: 20170601115111 05:31:01 INFO - mozversion platform_changeset: 0bcea6bac1797e14b00af45cc7c368d12460ab7f 05:31:01 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:31:01 INFO - mozversion platform_version: 55.0a1 05:31:01 INFO - using testdate: 1496320261 05:31:01 INFO - actual date: 1496320261 05:31:01 INFO - starting webserver on 'localhost:48919' 05:31:01 INFO - SUITE-START | Running 2 tests 05:31:01 INFO - TEST-START | dromaeo_css 05:31:01 INFO - operating with platform_type : linux_ 05:31:01 INFO - Initialising browser for dromaeo_css test... 05:31:01 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:48919/getInfo.html -profile /tmp/tmpA9v1JV/profile 05:31:01 INFO - TEST-INFO | started process 3363 (/builds/slave/test/build/application/firefox/firefox http://localhost:48919/getInfo.html) 05:31:39 INFO - TEST-INFO | 3363: killed by SIGTERM 05:31:39 INFO - Browser initialized. 05:31:39 INFO - Running cycle 1/1 for dromaeo_css test... 05:31:39 INFO - TEST-INFO | started process 3568 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpA9v1JV/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:31:51 INFO - PID 3568 | RSS: Main: 184020992 05:31:51 INFO - PID 3568 | 05:34:55 INFO - PID 3568 | Cycle 1(1): loaded http://localhost:48919/tests/dromaeo/cssquery-dojo.html (next: http://localhost:48919/tests/dromaeo/cssquery-ext.html) 05:34:57 INFO - PID 3568 | RSS: Main: 180330496 05:34:57 INFO - PID 3568 | 05:37:59 INFO - PID 3568 | Cycle 1(1): loaded http://localhost:48919/tests/dromaeo/cssquery-ext.html (next: http://localhost:48919/tests/dromaeo/cssquery-jquery.html) 05:37:59 INFO - PID 3568 | RSS: Main: 183480320 05:37:59 INFO - PID 3568 | 05:41:01 INFO - PID 3568 | Cycle 1(1): loaded http://localhost:48919/tests/dromaeo/cssquery-jquery.html (next: http://localhost:48919/tests/dromaeo/cssquery-mootools.html) 05:41:02 INFO - PID 3568 | RSS: Main: 181133312 05:41:02 INFO - PID 3568 | 05:44:03 INFO - PID 3568 | Cycle 1(1): loaded http://localhost:48919/tests/dromaeo/cssquery-mootools.html (next: http://localhost:48919/tests/dromaeo/cssquery-prototype.html) 05:44:04 INFO - PID 3568 | RSS: Main: 184647680 05:44:04 INFO - PID 3568 | 05:47:07 INFO - PID 3568 | Cycle 1(1): loaded http://localhost:48919/tests/dromaeo/cssquery-prototype.html (next: http://localhost:48919/tests/dromaeo/cssquery-yui.html) 05:47:08 INFO - PID 3568 | RSS: Main: 183640064 05:47:08 INFO - PID 3568 | 05:50:09 INFO - PID 3568 | Cycle 1(1): loaded http://localhost:48919/tests/dromaeo/cssquery-yui.html (next: http://localhost:48919/tests/dromaeo/cssquery-dojo.html) 05:50:10 INFO - PID 3568 | RSS: Main: 181436416 05:50:10 INFO - PID 3568 | 05:50:10 INFO - PID 3568 | __start_tp_report 05:50:10 INFO - PID 3568 | _x_x_mozilla_page_load 05:50:10 INFO - PID 3568 | _x_x_mozilla_page_load_details 05:50:10 INFO - PID 3568 | |i|pagename|runs| 05:50:10 INFO - PID 3568 | |0;dojo.html;2738.137486691692;2738.972610273899;2763.240108970033;2776.7917406194542;2777.055801027651;5153.510416510426;5283.365996080475;5304.814331498398;5320.388155362135;5347.35831700196;5272.578193744501;5284.2073688946675;5288.497592728694;5386.596005299599;5392.973035134819;4454.086912183011;4669.859904202863;4687.179743544874;4725.503822098682;4762.857114286559;4794.664373493857;4809.855704328876;4829.439240689325;4845.951540484603;4865.245886887538;4642.210824159901;4643.303504474356;4696.718196908162;4759.762011899391;4790.161721698689;4774.092922344744;4782;4803.063402636487;4814.975925120387;4823.252395878644;4729.172394830891;4729.219678753002;4740.07568524138;4744.5492678195515;4755.881102972418;5157.277981082614;5320.574354051667;5324.8136315228785;5346.117890548055;5351.518363347279;5653.802116925888;5688.97155514224;5765.509931655814;5775.480206781368;5776.33572139201;5802.97098514509;5808.12878068289;5817.0983497557945;5823.708814559255;5862.237909071836;5399.568034557226;5403.675779453245;5408.215808707715;5412.945870541244;5416.83749487516;5734.05388110957;5811.535077193815;5828.912566311508;5906;5948.524118070544;5649.830505084854;5673.886522269531;5683.204351390808;5712.885742285131;5721.828345149569;5633.521150702154;5734.426557344233;5736.913946290809;5739.282589676291;5743.827685169452;5530.889382212334;5591.608587398843;5711.343195532484;5733.025385684444;5734.799282025109;5669.858253543612;5706.115552089433;5731.656100633975;5748.626339287933;5767.480926716532;4675.275332323496;4678.087772884323;4696.365990591295;4698.130845793539;4735.763211839394;3948;4046.4537287466405;4060.959390406058;4061.8578349757618;4096.938545921814;4789.664723469394;4832;4871.098846713369;4875.780589873464;4876.926846097312;5769.163471296639;5770.509506691894;5786.913196302059;5794.21778059965;5830.854228644318;4872.634552408513;4875.658703890765;4880.682755620945;4897.3878265216845;4945.455999840086;4929.06347793918;4940.8764780880765;4992.525710057539;5038.974805125951;5064.949350506521;5423.783048678167;5425.077736784677;5452.372977107683;5478.123500239943;5492.835214943558;5609.663420194802;5657.858553536194;5682.9431705684065;5791.305043394819;5805.651660900359;5313.521783039545;5377.166539186433;5390.083685773349;5394.460553944574;5399.920015996738;5588.497035266683;5689.26039614864;5697.287839020122;5703.429657034263;5739.540836733135;5640.689762062962;5679.091345384719;5708.885822283448;5712.6286791358425;5763.02028655138;5606.635568688022;5618.2134501170685;5627.127795191588;5656.717164141859;5674.574406919415;5604.3835178131185;5613.186088017296;5613.775448981995;5614.943850561605;5616.775328986795;5307.548858347083;5378.112611419072;5451.64564303319;5506.834794956158;5551.8889622208135;5664.575156863334;5665.036943719495;5666.9716651416475;5669.886602268014;5701.543876489954;5430.13117901134;5452.100403433389;5457.781688732565;5465.398806131402;5467.316585426822 05:50:10 INFO - PID 3568 | |1;ext.html;705.8588282343529;754.0574282147315;768.2087449926576;1101.1631160318157;1105.9391733454656;32447.351052978956;32925.83537082317;33028.17429564256;33066.50400243995;33113;34045.82977085111;34194;34402;34437.48343774845;34529;6651.135352404181;6770.559913605624;6793.252742198354;6912.4470042396615;7060.5763654180655;6229.034499652538;6233.875322493547;6239.594426362295;6239.65681887496;6241.157443745082;6215.627062376272;6251.843703907393;6254.968725156368;6257.593256438339;6277.874442511147;6208.161898143738;6219.098230756537;6235;6235.625862448268;6244.875102497947;6748.696308666122;6763.12079429671;6779.389854913032;6789.796306110825;6817.5568588042115;31450;31777.682223177933;31830.681693183004;31835.52246716301;31847.681523184703;2756.4073724149202;2782.4574208029444;2782.874770635326;2786;2786.024891288033;24929.626055609;25115;25166;25180.24459266225;25184.748152518423;2920;2946.8526573671447;2960.5115155999233;2961.851907404621;2977.955330670042;121760.39119804432;122060.38969805183;131560.34219828935;138875;140140;38891.22217555633;39101;39102.41346379807;39152.41271380932;39169.41245881314;40239.39640905389;40515;40594.59405405908;40610.79694601508;43852.3422148668;11344.716382090513;11436.142289328334;11453.770924581628;11460.484278207501;11461.942690286494;8846.15961483658;8861.778455538662;8866.822663546693;8877.156670116328;8933.955330223438;12869;12881.935590321988;12883.613491595268;12908;12929.870701293055;5283.181106928432;5308.150695888639;5346.492083252085;5390.326209223847;5391.625135590478;864.3733293362262;905.1310741688053;916.5921165081475;916.6974898283551;935.5976929920064;20671.793282067287;21233.78766212318;21269.255576054762;21370.893145534483;21668.45828854291;972.4554249620236;980.7793246519476;986.7434467038622;1006.7684432580547;1007.7027276953316;11125.276857004268;11126.833097503544;11311.208215425006;11325.830112548318;11406.828897566544;172432.13783931252;172488;172617;173036.1348193251;173894;41131.38302925458;41178.79410602928;41420.792896035324;41433.1713365737;41573.1685366297;1181.3620644851856;1211.716248965314;1221.6090850927617;1224.9326287054298;1231.0213380362634;20217.494562635464;20474;21008.369748907557;21057.684134738298;21283.148674052863;29616.111516654535;29633.851830740707;29818.254543636584;29848.25379365533;29949.85025074861;147207.26396368377;147914;148339;148364;148495;28918.42163156767;29381.265468362606;29422.411551769274;29707.257318567208;29991;34802.82598586991;34839.129021773646;35932.46101308535;36134.27731445304;36739.63260367362;27027.59458608083;27223.455530888874;27247.31881702894;27251.318717032234;28033.299167520974;22325.888370558045;22455.32634020982;22455.88772056129;22524.774752252266;28590.571141433313;30867.2283192913;31630.683693162773;31777.20556986094;31997.520037198996;32111.67888321087;26830.731692682824;27742.306442339104;27819.860900695367;27865.721342786313;28005.859970700018;20105.6984145235;22385.44036399038;22524.774752252924;22550.661740073585;22580.774192257868 05:50:10 INFO - PID 3568 | |2;jquery.html;402.4607026584378;410.81923953460455;424.2829617945671;424.41854659117007;437.86645073252663;13121.606351809438;13298.13562118464;17729.556761080963;17739.37912173074;17775.37786177484;16118.7582186267;16572.917135414336;16739.748903766424;16766.41317553886;16799.748003779954;5527.585431092674;5675.489205971462;5715.0855863061915;5723.742431590588;5725.742341594639;5534.640248383862;5582.302212223472;5587.217789509452;5613.46672066153;5627.437256274381;5578.330600327967;5587.7485513152005;5587.832365029035;5588.692621905793;5604.691741954191;5106.259592359106;5287.9424115176735;5312.973435132838;5327.907778905315;5578.24693666356;4804.183288840905;4843.055604157191;4845.030993801254;4846.5880400166025;4850.393700787402;22379;22667.31998040045;22738.77261227383;22758.317250482512;22760.975756091015;1610.3397606981082;1657.767912492252;1661.534770264328;1664.1845495707016;1668.966620667592;14811.407543698238;15055.924720376437;15059.774103388458;15306.846931530654;15397.076175429398;2076.927307544229;2090.822280106193;2098.034903944172;2129.9041543130597;2149.322963266566;101340.49329753304;101858;103569.48215258951;104896.47551762192;105311;10666.626668066581;10976;11026.944865275782;11207.71980700489;11559.190856639954;15916.76124858128;15957.840421595636;15960.840391595935;15981.760273595906;16017.43938962154;7738.2261773822165;7951.761447156595;7971.123176450586;8038.477498962548;8046.718364857202;7370.189279179286;7375;7402.407807375397;7473.140588832245;7489.138749043821;7336.596487193149;7352.963235183897;7444.404447644176;7474.626268686653;7563.9621801891735;2044.808143306246;2049.6515592349338;2090;2124.5963266979224;2168.7072245247005;826.6321486938375;867.6355930509201;888.9066648001996;904.977375565603;912.2747415804452;17504;17583.73624395635;17722.734158987627;17989.640207195782;18010.099495025195;871.9912800872037;879.1955360844884;882.3294296334703;886.4504007515382;910.4537277633367;9616.95191524038;9637.614495420245;9653.951730241304;9999.550020249106;10117.848232276521;339400;347971;349585;349687;350959;81343.59328203321;81627;82939.58530207431;83699.16300836914;84106;998.8601595776597;1021.4228960637216;1052.6999805055675;1054.5939813171983;1062.2511129653576;15249.771253431429;15437.614059648598;15733.370665173265;15892.841071589137;16174.191290435667;41852;42048.36927446152;42101.57898421099;43242.13515729605;43522.12955740931;52011.21983170331;52153.73923130512;52156.73921630368;52241.7387913058;53058.4694153069;9474.621015159317;9475.952620236854;9581.185599224144;9754.463504507321;9765.169960553432;15347.923260383626;16132.354705811636;16388.26252818602;16805.41181058657;16974;12585.622431327074;12644.936775316064;12695.238285702888;13770.31148442594;13819.654508637364;12071.879281207075;12388.628341149419;12514.18657787241;12548.874511254771;12600.369981501071;12816.231026138461;12919.354032298535;12927.224366538037;14074.577762667137;14122.082064666174;9605.951970240105;9646.228301735704;9735.756606084904;9738.269629777653;9750.902490974999;13224.735505289647;13310.933445332712;13355.131916425402;13355.53255636048;13383.53157639478 05:50:10 INFO - PID 3568 | |3;mootools.html;1265.3609926986871;1316.1116246533588;1316.9802452963202;1327.396034804164;1328.5018118205667;10058.798824023515;10311.43287119208;10509.369437833735;10511.52698128584;10947.781044379108;10464.52909619067;10593.73515662107;10608.310459820126;10652.893471065307;10662.733431664212;1975.565375617369;2013.3355992522506;2014.3654748754168;2014.6172227276843;2022.0496366707698;1953.687410014398;2008.9196432142696;2011.1050582490798;2017.788132246115;2023.5952809438097;1974.2004488182238;1992.3226103124935;2002.0690378973775;2012.034223572686;2012.7987201279902;1954.921803127873;1963.7643482782157;1964.489232799468;1965.2139144342234;1966.016991504248;1909.885406875578;1921.9231230750754;1971.2016633263552;2056.6709326507835;2062.0308455026116;10438.321509101885;10537.315074520131;10539;10547.525361358757;10552.261341706084;5344.412114667383;5539.556835453154;5541.889162216773;5542.168674698787;5545.944540554624;3066.5400189971683;3194.952075718866;3224.3873664004;3234.96765032349;3250.0737289872272;1011.4942528735633;1014.9949250253701;1044.853720479126;1055.2824079625852;1083.9783204335947;15512.14683192424;16006.679866402723;16175.757363639555;16195.595110122224;16232.107234102119;4603.263477843596;4644.883877903079;4777.307290442866;4808;4824.421069471686;11381.317120972768;11482.540698372139;11514.251573647685;11547.942260288813;11561.76876462466;5317.1492561190025;5407.540359069444;5419.187121931742;5424.538914192338;5425.104857698515;4797.832075877328;4869.732164730974;4881.096997055556;4883.02339532095;4886.364772579542;3966.4446977423186;3992.1416895367056;4050.4734384529825;4069.4302797608357;4075.49056367954;1061.7239517725448;1066.0618655583037;1073.3184427888348;1077.9407132607782;1082.5723839083519;648.3937518420198;673.6800019990563;686.7767975408012;693.930606939302;698.91263592051;5404.621676482609;5554.666719996813;5597.580181486404;5653.265075540236;5734.082546792493;491.5993465325748;495.0000997984052;495.15081634996153;509.15480302698086;509.9311592934906;3311.569495965509;3889.9611003890163;3920.862769803043;3942.9605703943166;4075.918481630351;12991.870081299066;13059.608211753473;13397.66505837362;13410.798838017437;13540.322983850769;12958.481471522551;13317.400716967759;13492;13555.051146419853;13576.253306068262;7362.705491780269;7426.962865185639;7534.397248220129;7550.093988721389;7618.657160427794;5485.698286594116;5589.916151257653;5735.913961290667;5874.676892770939;5969.403059693996;12085.637430877088;12339.07456940715;12382.885540301417;12493.812592810933;12515.249085054926;12629.11596188258;12696.619101426972;12876;12936.870631293566;12947.417366218731;8270.297024752963;8431.873521897054;8449.02836173848;8465.407421480437;8483.74548763538;9908.108270255712;10021.599136034478;10022.899771002196;10023.198144148597;10030.348027378197;8259.256666900008;8355.331573474228;8593.269572086192;8660.004099528383;8677.522736249566;7922.564258965812;7978.920210797818;8028.237317454832;8033.517988920684;8105.148959359418;7672.961635192011;7808.258215469521;7810;7816.452848300792;7836.686532538634;5328.62699611039;5334.51989320963;5398.946010540001;5441.891162176814;5667.149927510906;5087.3386459759995;5120.257562653469;5171;5333.839984800462;5352.437994010573 05:50:10 INFO - PID 3568 | |4;prototype.html;352.140776505327;356.67186188706404;357.2230398882431;357.85864583489507;361.6239111324222;5361.731913404334;5561.888762224753;5606.523445507131;5617.8033768818095;5646.322441307038;5352.57179425645;5423.972880135594;5431.538319242869;5432.538234250083;5439.265699130626;4062.4921884764403;4067.4712287402594;4095.365218391139;4104.220198162339;4105.117399759051;4094.6110119538744;4097.856575019875;4102.640981435671;4103.610157035077;4105.651019663317;4069.3489041753323;4086.1010577673014;4086.9182616347803;4096.877093687194;4106.466159399274;4068.735532190413;4081.897952551195;4085.3054980653064;4086.570910054461;4104.938425923614;3585.3904836177912;3593.4609808528667;3593.6406359364114;3602.837872295753;3608.7654302470255;5324.680519168863;5350.705711185883;5357.785688572452;5367.597430192751;5382.9730851345885;4778.661974647104;4780.306855505932;4803.0874133914795;4810.158222311082;4820.528699925575;5757.395473475309;5758.9633865904125;5770.221020162308;5775.8556036099435;5786.47921687046;3970.801459927021;3977.840886364542;3982.362821948503;4005.819738111792;4028.6575641070544;5747.942520574783;6108.5418593605655;6158.7228574714245;6198.2252218472695;6204.007358822611;4018.2566225248424;4030.3954406839207;4039.414284928669;4039.636432721069;4059.7361171523758;4093.2222877653153;4095.0990782027907;4117;4120.846163074344;4126.463559737275;4632.374629425052;4720.811167553328;4733.810647574127;4754.95245047552;4773.522647735199;5750.769969201268;5786.971065144648;5803.448672376117;5806.693493963824;5828.883422331614;1422.9786553201711;1425.187643043476;1429.385364293343;1431.9546730886302;1431.992840035793;916.4592890194817;962.0667952086465;966.087047739879;969.7769513012047;972.5040229482873;5045.369328833895;5053.646244762831;5054.115529782273;5056.595472362203;5076.44159142494;5978.551608629283;5982.4017598239825;5996.841137190608;6019.277686677539;6027.186329845415;4985.626078044161;5031.144705400091;5032.949670503322;5038.093143234253;5040.974795126001;3156.2425017995974;3168.8574014169417;3172.984135079356;3175;3180.2367431816197;5606.355269144019;5618.185363122325;5622.072358060956;5629.155626656035;5674.659520428788;6069.726862291208;6129.662868542273;6133.815985520441;6151.6001459904965;6162.952298109332;5613.635113717677;5642.689652069093;5648.15277708347;5666.688332141772;5682.488576028178;5986.4013598639785;5989.8203053908455;5998.160257563857;6000.489958353589;6002.589391492908;5870.5010074144175;5876.588638795243;5878.617889837147;5895.145203945318;5912.113183022581;5303.6663867898005;5545.556355491471;5621.184928185472;5626.127950167731;5639.605227634026;4075.531313898821;4091.713580049487;4104.199681062164;4107.158032603369;4112.444819949268;5828.94171058284;5984.431479009487;5997.670128142994;6000.339962604023;6006.459418652343;5786.566007549366;5791.391903850035;5806.925718742046;5838.708064596838;5839.5036421904615;5822.737976791139;5841.737121829613;5849.795257165979;5851.1223316502865;5857.677827719516;5724.771009159587;5749.13762935563;5752.884942301214;5755.942440575541;5758.798442054508;5838.474537291664;5846.216903844198;5855.765769369177;5872.060470324727;5900.763969441175;5632.5212356950115;5711.857203569944;5733.741981610921;5750.5112065474905;5763.394843541536 05:50:10 INFO - PID 3568 | |5;yui.html;743.3867059675762;749.1609397474829;764.7399884039426;769.6267310354478;772.6484449575444;11119.221654484189;11685.824712629317;12579;13531.458741650335;13567.389467473975;13954;14141.292935353216;14338.928305358484;14383.496577619786;14447.422103115889;870.5995242188585;890.7416849113749;896.090468174803;896.2874514760748;896.3277541843618;826.3802148388709;898.6674930275807;899.190728344492;900.4417261297972;901.6303315640589;943.0522325063301;957.34421920984;957.7461972577272;959.0457494792691;960.9807803843919;943.3820847345;949.6059135458777;950.8668786369914;954.1651055326624;958.6453012385392;693.1681981622073;696.6830092308038;696.7143471176844;698.3958875572644;698.4761428928304;13174.86825131746;13194.538191163263;13220.272884991322;13221.669458263525;13254.46982120714;15077.623059423493;15446;15954.202289885576;16006.119663418507;16040.518784436486;12094.576689815814;12101.273923564615;12185;12247.203931744409;12260.81608775869;3048.039867441771;3068.140920542252;3077.692230776927;3081.3837232553356;3083.8612262448246;82528.58735706343;83921.16078839256;84175.57912210461;84600;85052.57473712653;11666.70833229176;11732.178747487764;11883.524659013716;11886;12000.819987700192;22440.551188976457;22910.885445573;23304.65043024356;23343;23349;6134.04922237054;6153.323134455206;6170.845728856814;6199.225096862892;6208.255009398811;2856.957145642817;2939.426811771684;3044.071558174778;3059.2351912021995;3065.908022759321;3425.6060553036223;3939.2515422069714;4205.474315710536;4205.831766729358;4217.030083080908;765.670761572518;776.4836383804707;787.1262898183012;796.366888323784;801.0907619851511;589.5519405252039;601.8886505996404;603.4508597176548;617.0867116667267;627.2065836716557;9949.850752238723;10400.791984160274;10404.947975260227;10491.737706557396;10597.311174773615;572.8882867840814;581.8050952930731;582.5892745614332;592.5259792166249;602.1028667285713;4425.424694789656;4628.213203755369;4665.2768820832825;4717.716936983792;4826.396700412449;86246.56876715577;86384;86649;87321;88557.11442885488;77046;78244;78758;79095;79132.20867791248;65806.67096664582;66375.66812166006;66520.33479665239;66830.3316966824;67743.32256677469;8887.644494220418;9151.084891510796;9353.906460935576;9513.191378732885;9651;29475;30038.24904377408;30247.243818904702;30263;30804.53793193059;36823.26353472969;37423.25153496969;37423.625763743104;37872;38211;11575.88424115748;11900.107491938312;13389.933050335076;14231.07498012626;14411.207383594003;15248.618784530476;15962.521124366287;15979.280932357839;16023.278952447401;16167.029978201346;14022.649433763829;14100.36548355306;14151.080179788692;14252.786208206679;14320.06919550226;14237.64405889861;14337.139771613736;14485.637859053186;14649.26753662334;14661.340239689453;13239;13306.268155251553;13831.86168138346;13895.72208555803;13971.510997115052;9835.016498350107;10261.846072308772;10336.844947325946;10617.946910265398;11132.888671113185;10040.949795251268;10916.945415272872;10935.45322733876;10984.231103822656;11053.226274160732 05:50:10 INFO - PID 3568 | __end_tp_report 05:50:10 INFO - PID 3568 | __start_cc_report 05:50:10 INFO - PID 3568 | _x_x_mozilla_cycle_collect,386 05:50:10 INFO - PID 3568 | __end_cc_report 05:50:10 INFO - PID 3568 | __startTimestamp1496321410001__endTimestamp 05:50:10 INFO - PID 3568 | 05:50:10 INFO - PID 3568 | ------- Summary: start ------- 05:50:10 INFO - PID 3568 | Number of tests: 6 05:50:10 INFO - PID 3568 | 05:50:10 INFO - PID 3568 | [#0] dojo.html Cycles:165 Average:5242.63 Median:5423.78 stddev:627.76 (11.6%) stddev-sans-first:598.15 05:50:10 INFO - PID 3568 | Values: 2738.1 2739.0 2763.2 2776.8 2777.1 5153.5 5283.4 5304.8 5320.4 5347.4 5272.6 5284.2 5288.5 5386.6 5393.0 4454.1 4669.9 4687.2 4725.5 4762.9 4794.7 4809.9 4829.4 4846.0 4865.2 4642.2 4643.3 4696.7 4759.8 4790.2 4774.1 4782.0 4803.1 4815.0 4823.3 4729.2 4729.2 4740.1 4744.5 4755.9 5157.3 5320.6 5324.8 5346.1 5351.5 5653.8 5689.0 5765.5 5775.5 5776.3 5803.0 5808.1 5817.1 5823.7 5862.2 5399.6 5403.7 5408.2 5412.9 5416.8 5734.1 5811.5 5828.9 5906.0 5948.5 5649.8 5673.9 5683.2 5712.9 5721.8 5633.5 5734.4 5736.9 5739.3 5743.8 5530.9 5591.6 5711.3 5733.0 5734.8 5669.9 5706.1 5731.7 5748.6 5767.5 4675.3 4678.1 4696.4 4698.1 4735.8 3948.0 4046.5 4061.0 4061.9 4096.9 4789.7 4832.0 4871.1 4875.8 4876.9 5769.2 5770.5 5786.9 5794.2 5830.9 4872.6 4875.7 4880.7 4897.4 4945.5 4929.1 4940.9 4992.5 5039.0 5064.9 5423.8 5425.1 5452.4 5478.1 5492.8 5609.7 5657.9 5682.9 5791.3 5805.7 5313.5 5377.2 5390.1 5394.5 5399.9 5588.5 5689.3 5697.3 5703.4 5739.5 5640.7 5679.1 5708.9 5712.6 5763.0 5606.6 5618.2 5627.1 5656.7 5674.6 5604.4 5613.2 5613.8 5614.9 5616.8 5307.5 5378.1 5451.6 5506.8 5551.9 5664.6 5665.0 5667.0 5669.9 5701.5 5430.1 5452.1 5457.8 5465.4 5467.3 05:50:10 INFO - PID 3568 | 05:50:10 INFO - PID 3568 | [#1] ext.html Cycles:180 Average:29410.76 Median:29833.25 stddev:39176.74 (131.3%) stddev-sans-first:39227.35 05:50:10 INFO - PID 3568 | Values: 705.9 754.1 768.2 1101.2 1105.9 32447.4 32925.8 33028.2 33066.5 33113.0 34045.8 34194.0 34402.0 34437.5 34529.0 6651.1 6770.6 6793.3 6912.4 7060.6 6229.0 6233.9 6239.6 6239.7 6241.2 6215.6 6251.8 6255.0 6257.6 6277.9 6208.2 6219.1 6235.0 6235.6 6244.9 6748.7 6763.1 6779.4 6789.8 6817.6 31450.0 31777.7 31830.7 31835.5 31847.7 2756.4 2782.5 2782.9 2786.0 2786.0 24929.6 25115.0 25166.0 25180.2 25184.7 2920.0 2946.9 2960.5 2961.9 2978.0 121760.4 122060.4 131560.3 138875.0 140140.0 38891.2 39101.0 39102.4 39152.4 39169.4 40239.4 40515.0 40594.6 40610.8 43852.3 11344.7 11436.1 11453.8 11460.5 11461.9 8846.2 8861.8 8866.8 8877.2 8934.0 12869.0 12881.9 12883.6 12908.0 12929.9 5283.2 5308.2 5346.5 5390.3 5391.6 864.4 905.1 916.6 916.7 935.6 20671.8 21233.8 21269.3 21370.9 21668.5 972.5 980.8 986.7 1006.8 1007.7 11125.3 11126.8 11311.2 11325.8 11406.8 172432.1 172488.0 172617.0 173036.1 173894.0 41131.4 41178.8 41420.8 41433.2 41573.2 1181.4 1211.7 1221.6 1224.9 1231.0 20217.5 20474.0 21008.4 21057.7 21283.1 29616.1 29633.9 29818.3 29848.3 29949.9 147207.3 147914.0 148339.0 148364.0 148495.0 28918.4 29381.3 29422.4 29707.3 29991.0 34802.8 34839.1 35932.5 36134.3 36739.6 27027.6 27223.5 27247.3 27251.3 28033.3 22325.9 22455.3 22455.9 22524.8 28590.6 30867.2 31630.7 31777.2 31997.5 32111.7 26830.7 27742.3 27819.9 27865.7 28005.9 20105.7 22385.4 22524.8 22550.7 22580.8 05:50:10 INFO - PID 3568 | 05:50:10 INFO - PID 3568 | [#2] jquery.html Cycles:180 Average:25442.64 Median:343685.50 stddev:58700.50 (17.1%) stddev-sans-first:58835.07 05:50:10 INFO - PID 3568 | Values: 402.5 410.8 424.3 424.4 437.9 13121.6 13298.1 17729.6 17739.4 17775.4 16118.8 16572.9 16739.7 16766.4 16799.7 5527.6 5675.5 5715.1 5723.7 5725.7 5534.6 5582.3 5587.2 5613.5 5627.4 5578.3 5587.7 5587.8 5588.7 5604.7 5106.3 5287.9 5313.0 5327.9 5578.2 4804.2 4843.1 4845.0 4846.6 4850.4 22379.0 22667.3 22738.8 22758.3 22761.0 1610.3 1657.8 1661.5 1664.2 1669.0 14811.4 15055.9 15059.8 15306.8 15397.1 2076.9 2090.8 2098.0 2129.9 2149.3 101340.5 101858.0 103569.5 104896.5 105311.0 10666.6 10976.0 11026.9 11207.7 11559.2 15916.8 15957.8 15960.8 15981.8 16017.4 7738.2 7951.8 7971.1 8038.5 8046.7 7370.2 7375.0 7402.4 7473.1 7489.1 7336.6 7353.0 7444.4 7474.6 7564.0 2044.8 2049.7 2090.0 2124.6 2168.7 826.6 867.6 888.9 905.0 912.3 17504.0 17583.7 17722.7 17989.6 18010.1 872.0 879.2 882.3 886.5 910.5 9617.0 9637.6 9654.0 9999.6 10117.8 339400.0 347971.0 349585.0 349687.0 350959.0 81343.6 81627.0 82939.6 83699.2 84106.0 998.9 1021.4 1052.7 1054.6 1062.3 15249.8 15437.6 15733.4 15892.8 16174.2 41852.0 42048.4 42101.6 43242.1 43522.1 52011.2 52153.7 52156.7 52241.7 53058.5 9474.6 9476.0 9581.2 9754.5 9765.2 15347.9 16132.4 16388.3 16805.4 16974.0 12585.6 12644.9 12695.2 13770.3 13819.7 12071.9 12388.6 12514.2 12548.9 12600.4 12816.2 12919.4 12927.2 14074.6 14122.1 9606.0 9646.2 9735.8 9738.3 9750.9 13224.7 13310.9 13355.1 13355.5 13383.5 05:50:10 INFO - PID 3568 | 05:50:10 INFO - PID 3568 | [#3] mootools.html Cycles:180 Average:6368.36 Median:3209.67 stddev:4263.97 (132.8%) stddev-sans-first:4258.69 05:50:10 INFO - PID 3568 | Values: 1265.4 1316.1 1317.0 1327.4 1328.5 10058.8 10311.4 10509.4 10511.5 10947.8 10464.5 10593.7 10608.3 10652.9 10662.7 1975.6 2013.3 2014.4 2014.6 2022.0 1953.7 2008.9 2011.1 2017.8 2023.6 1974.2 1992.3 2002.1 2012.0 2012.8 1954.9 1963.8 1964.5 1965.2 1966.0 1909.9 1921.9 1971.2 2056.7 2062.0 10438.3 10537.3 10539.0 10547.5 10552.3 5344.4 5539.6 5541.9 5542.2 5545.9 3066.5 3195.0 3224.4 3235.0 3250.1 1011.5 1015.0 1044.9 1055.3 1084.0 15512.1 16006.7 16175.8 16195.6 16232.1 4603.3 4644.9 4777.3 4808.0 4824.4 11381.3 11482.5 11514.3 11547.9 11561.8 5317.1 5407.5 5419.2 5424.5 5425.1 4797.8 4869.7 4881.1 4883.0 4886.4 3966.4 3992.1 4050.5 4069.4 4075.5 1061.7 1066.1 1073.3 1077.9 1082.6 648.4 673.7 686.8 693.9 698.9 5404.6 5554.7 5597.6 5653.3 5734.1 491.6 495.0 495.2 509.2 509.9 3311.6 3890.0 3920.9 3943.0 4075.9 12991.9 13059.6 13397.7 13410.8 13540.3 12958.5 13317.4 13492.0 13555.1 13576.3 7362.7 7427.0 7534.4 7550.1 7618.7 5485.7 5589.9 5735.9 5874.7 5969.4 12085.6 12339.1 12382.9 12493.8 12515.2 12629.1 12696.6 12876.0 12936.9 12947.4 8270.3 8431.9 8449.0 8465.4 8483.7 9908.1 10021.6 10022.9 10023.2 10030.3 8259.3 8355.3 8593.3 8660.0 8677.5 7922.6 7978.9 8028.2 8033.5 8105.1 7673.0 7808.3 7810.0 7816.5 7836.7 5328.6 5334.5 5398.9 5441.9 5667.1 5087.3 5120.3 5171.0 5333.8 5352.4 05:50:10 INFO - PID 3568 | 05:50:10 INFO - PID 3568 | [#4] prototype.html Cycles:180 Average:4763.54 Median:5435.90 stddev:1431.06 (26.3%) stddev-sans-first:1396.24 05:50:10 INFO - PID 3568 | Values: 352.1 356.7 357.2 357.9 361.6 5361.7 5561.9 5606.5 5617.8 5646.3 5352.6 5424.0 5431.5 5432.5 5439.3 4062.5 4067.5 4095.4 4104.2 4105.1 4094.6 4097.9 4102.6 4103.6 4105.7 4069.3 4086.1 4086.9 4096.9 4106.5 4068.7 4081.9 4085.3 4086.6 4104.9 3585.4 3593.5 3593.6 3602.8 3608.8 5324.7 5350.7 5357.8 5367.6 5383.0 4778.7 4780.3 4803.1 4810.2 4820.5 5757.4 5759.0 5770.2 5775.9 5786.5 3970.8 3977.8 3982.4 4005.8 4028.7 5747.9 6108.5 6158.7 6198.2 6204.0 4018.3 4030.4 4039.4 4039.6 4059.7 4093.2 4095.1 4117.0 4120.8 4126.5 4632.4 4720.8 4733.8 4755.0 4773.5 5750.8 5787.0 5803.4 5806.7 5828.9 1423.0 1425.2 1429.4 1432.0 1432.0 916.5 962.1 966.1 969.8 972.5 5045.4 5053.6 5054.1 5056.6 5076.4 5978.6 5982.4 5996.8 6019.3 6027.2 4985.6 5031.1 5032.9 5038.1 5041.0 3156.2 3168.9 3173.0 3175.0 3180.2 5606.4 5618.2 5622.1 5629.2 5674.7 6069.7 6129.7 6133.8 6151.6 6163.0 5613.6 5642.7 5648.2 5666.7 5682.5 5986.4 5989.8 5998.2 6000.5 6002.6 5870.5 5876.6 5878.6 5895.1 5912.1 5303.7 5545.6 5621.2 5626.1 5639.6 4075.5 4091.7 4104.2 4107.2 4112.4 5828.9 5984.4 5997.7 6000.3 6006.5 5786.6 5791.4 5806.9 5838.7 5839.5 5822.7 5841.7 5849.8 5851.1 5857.7 5724.8 5749.1 5752.9 5755.9 5758.8 5838.5 5846.2 5855.8 5872.1 5900.8 5632.5 5711.9 5733.7 5750.5 5763.4 05:50:10 INFO - PID 3568 | 05:50:10 INFO - PID 3568 | [#5] yui.html Cycles:180 Average:17412.33 Median:37423.44 stddev:23511.69 (62.8%) stddev-sans-first:23544.33 05:50:10 INFO - PID 3568 | Values: 743.4 749.2 764.7 769.6 772.6 11119.2 11685.8 12579.0 13531.5 13567.4 13954.0 14141.3 14338.9 14383.5 14447.4 870.6 890.7 896.1 896.3 896.3 826.4 898.7 899.2 900.4 901.6 943.1 957.3 957.7 959.0 961.0 943.4 949.6 950.9 954.2 958.6 693.2 696.7 696.7 698.4 698.5 13174.9 13194.5 13220.3 13221.7 13254.5 15077.6 15446.0 15954.2 16006.1 16040.5 12094.6 12101.3 12185.0 12247.2 12260.8 3048.0 3068.1 3077.7 3081.4 3083.9 82528.6 83921.2 84175.6 84600.0 85052.6 11666.7 11732.2 11883.5 11886.0 12000.8 22440.6 22910.9 23304.7 23343.0 23349.0 6134.0 6153.3 6170.8 6199.2 6208.3 2857.0 2939.4 3044.1 3059.2 3065.9 3425.6 3939.3 4205.5 4205.8 4217.0 765.7 776.5 787.1 796.4 801.1 589.6 601.9 603.5 617.1 627.2 9949.9 10400.8 10404.9 10491.7 10597.3 572.9 581.8 582.6 592.5 602.1 4425.4 4628.2 4665.3 4717.7 4826.4 86246.6 86384.0 86649.0 87321.0 88557.1 77046.0 78244.0 78758.0 79095.0 79132.2 65806.7 66375.7 66520.3 66830.3 67743.3 8887.6 9151.1 9353.9 9513.2 9651.0 29475.0 30038.2 30247.2 30263.0 30804.5 36823.3 37423.3 37423.6 37872.0 38211.0 11575.9 11900.1 13389.9 14231.1 14411.2 15248.6 15962.5 15979.3 16023.3 16167.0 14022.6 14100.4 14151.1 14252.8 14320.1 14237.6 14337.1 14485.6 14649.3 14661.3 13239.0 13306.3 13831.9 13895.7 13971.5 9835.0 10261.8 10336.8 10617.9 11132.9 10040.9 10916.9 10935.5 10984.2 11053.2 05:50:10 INFO - PID 3568 | -------- Summary: end -------- 05:50:10 INFO - PID 3568 | 05:50:10 INFO - TEST-INFO | 3568: exit 0 05:50:10 INFO - TEST-OK | dromaeo_css | took 1149240ms 05:50:10 INFO - TEST-START | kraken 05:50:10 INFO - operating with platform_type : linux_ 05:50:10 INFO - Initialising browser for kraken test... 05:50:10 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:48919/getInfo.html -profile /tmp/tmpZIPQer/profile 05:50:10 INFO - TEST-INFO | started process 3976 (/builds/slave/test/build/application/firefox/firefox http://localhost:48919/getInfo.html) 05:50:46 INFO - TEST-INFO | 3976: killed by SIGTERM 05:50:46 INFO - Browser initialized. 05:50:46 INFO - Running cycle 1/1 for kraken test... 05:50:46 INFO - TEST-INFO | started process 4186 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZIPQer/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:50:58 INFO - PID 4186 | RSS: Main: 184025088 05:50:58 INFO - PID 4186 | 05:51:00 INFO - PID 4186 | Cycle 1(1): loaded http://localhost:48919/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:48919/tests/kraken/driver.html?testName=audio-beat-detection) 05:51:01 INFO - PID 4186 | RSS: Main: 187031552 05:51:01 INFO - PID 4186 | 05:51:04 INFO - PID 4186 | Cycle 1(1): loaded http://localhost:48919/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:48919/tests/kraken/driver.html?testName=audio-dft) 05:51:05 INFO - PID 4186 | RSS: Main: 186585088 05:51:05 INFO - PID 4186 | 05:51:08 INFO - PID 4186 | Cycle 1(1): loaded http://localhost:48919/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:48919/tests/kraken/driver.html?testName=audio-fft) 05:51:08 INFO - PID 4186 | RSS: Main: 181886976 05:51:08 INFO - PID 4186 | 05:51:10 INFO - PID 4186 | Cycle 1(1): loaded http://localhost:48919/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:48919/tests/kraken/driver.html?testName=audio-oscillator) 05:51:11 INFO - PID 4186 | RSS: Main: 181944320 05:51:11 INFO - PID 4186 | 05:51:13 INFO - PID 4186 | Cycle 1(1): loaded http://localhost:48919/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:48919/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:51:14 INFO - PID 4186 | RSS: Main: 182546432 05:51:14 INFO - PID 4186 | 05:51:17 INFO - PID 4186 | Cycle 1(1): loaded http://localhost:48919/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:48919/tests/kraken/driver.html?testName=imaging-darkroom) 05:51:17 INFO - PID 4186 | RSS: Main: 183615488 05:51:17 INFO - PID 4186 | 05:51:21 INFO - PID 4186 | Cycle 1(1): loaded http://localhost:48919/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:48919/tests/kraken/driver.html?testName=imaging-desaturate) 05:51:22 INFO - PID 4186 | RSS: Main: 182542336 05:51:22 INFO - PID 4186 | 05:51:24 INFO - PID 4186 | Cycle 1(1): loaded http://localhost:48919/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:48919/tests/kraken/driver.html?testName=json-parse-financial) 05:51:25 INFO - PID 4186 | RSS: Main: 183451648 05:51:25 INFO - PID 4186 | 05:51:27 INFO - PID 4186 | Cycle 1(1): loaded http://localhost:48919/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:48919/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:51:27 INFO - PID 4186 | RSS: Main: 183197696 05:51:27 INFO - PID 4186 | 05:51:29 INFO - PID 4186 | Cycle 1(1): loaded http://localhost:48919/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:48919/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:51:30 INFO - PID 4186 | RSS: Main: 183279616 05:51:30 INFO - PID 4186 | 05:51:32 INFO - PID 4186 | Cycle 1(1): loaded http://localhost:48919/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:48919/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:51:33 INFO - PID 4186 | RSS: Main: 183336960 05:51:33 INFO - PID 4186 | 05:51:36 INFO - PID 4186 | Cycle 1(1): loaded http://localhost:48919/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:48919/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:51:36 INFO - PID 4186 | RSS: Main: 183209984 05:51:36 INFO - PID 4186 | 05:51:39 INFO - PID 4186 | Cycle 1(1): loaded http://localhost:48919/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:48919/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:51:40 INFO - PID 4186 | RSS: Main: 183111680 05:51:40 INFO - PID 4186 | 05:51:42 INFO - PID 4186 | Cycle 1(1): loaded http://localhost:48919/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:48919/tests/kraken/driver.html?testName=ai-astar) 05:51:42 INFO - PID 4186 | RSS: Main: 184504320 05:51:42 INFO - PID 4186 | 05:51:42 INFO - PID 4186 | __start_tp_report 05:51:42 INFO - PID 4186 | _x_x_mozilla_page_load 05:51:42 INFO - PID 4186 | _x_x_mozilla_page_load_details 05:51:42 INFO - PID 4186 | |i|pagename|runs| 05:51:42 INFO - PID 4186 | |0;ai-astar;106;112;112;111;111;112;112;112;112;112 05:51:42 INFO - PID 4186 | |1;audio-beat-detection;150;123;124;173;123;124;124;124;148;124 05:51:42 INFO - PID 4186 | |2;audio-dft;164;164;163;165;168;172;169;163;163;162 05:51:42 INFO - PID 4186 | |3;audio-fft;74;79;74;110;75;74;75;75;96;75 05:51:42 INFO - PID 4186 | |4;audio-oscillator;83;82;98;84;83;85;97;84;82;109 05:51:42 INFO - PID 4186 | |5;imaging-gaussian-blur;115;114;114;115;114;114;114;115;114;114 05:51:42 INFO - PID 4186 | |6;imaging-darkroom;151;150;151;151;151;150;151;150;152;151 05:51:42 INFO - PID 4186 | |7;imaging-desaturate;99;95;94;94;94;95;94;94;95;94 05:51:42 INFO - PID 4186 | |8;json-parse-financial;58;55;56;57;56;56;58;58;57;58 05:51:42 INFO - PID 4186 | |9;json-stringify-tinderbox;57;56;56;55;56;59;56;56;56;56 05:51:42 INFO - PID 4186 | |10;stanford-crypto-aes;86;88;88;87;86;88;87;89;125;86 05:51:42 INFO - PID 4186 | |11;stanford-crypto-ccm;135;132;133;139;132;137;137;138;134;150 05:51:42 INFO - PID 4186 | |12;stanford-crypto-pbkdf2;202;198;197;195;196;200;197;197;201;196 05:51:42 INFO - PID 4186 | |13;stanford-crypto-sha256-iterative;76;76;74;73;72;73;76;82;74;72 05:51:42 INFO - PID 4186 | __end_tp_report 05:51:42 INFO - PID 4186 | __start_cc_report 05:51:42 INFO - PID 4186 | _x_x_mozilla_cycle_collect,1044 05:51:42 INFO - PID 4186 | __end_cc_report 05:51:42 INFO - PID 4186 | __startTimestamp1496321502618__endTimestamp 05:51:42 INFO - PID 4186 | 05:51:42 INFO - PID 4186 | ------- Summary: start ------- 05:51:42 INFO - PID 4186 | Number of tests: 14 05:51:42 INFO - PID 4186 | 05:51:42 INFO - PID 4186 | [#0] ai-astar Cycles:10 Average:111.20 Median:112.00 stddev:1.87 (1.7%) stddev-sans-first:0.44 05:51:42 INFO - PID 4186 | Values: 106.0 112.0 112.0 111.0 111.0 112.0 112.0 112.0 112.0 112.0 05:51:42 INFO - PID 4186 | 05:51:42 INFO - PID 4186 | [#1] audio-beat-detection Cycles:10 Average:133.70 Median:124.00 stddev:17.37 (14.0%) stddev-sans-first:17.39 05:51:42 INFO - PID 4186 | Values: 150.0 123.0 124.0 173.0 123.0 124.0 124.0 124.0 148.0 124.0 05:51:42 INFO - PID 4186 | 05:51:42 INFO - PID 4186 | [#2] audio-dft Cycles:10 Average:165.30 Median:164.50 stddev:3.27 (2.0%) stddev-sans-first:3.43 05:51:42 INFO - PID 4186 | Values: 164.0 164.0 163.0 165.0 168.0 172.0 169.0 163.0 163.0 162.0 05:51:42 INFO - PID 4186 | 05:51:42 INFO - PID 4186 | [#3] audio-fft Cycles:10 Average:80.70 Median:75.00 stddev:12.29 (16.4%) stddev-sans-first:12.80 05:51:42 INFO - PID 4186 | Values: 74.0 79.0 74.0 110.0 75.0 74.0 75.0 75.0 96.0 75.0 05:51:42 INFO - PID 4186 | 05:51:42 INFO - PID 4186 | [#4] audio-oscillator Cycles:10 Average:88.70 Median:84.00 stddev:9.31 (11.1%) stddev-sans-first:9.64 05:51:42 INFO - PID 4186 | Values: 83.0 82.0 98.0 84.0 83.0 85.0 97.0 84.0 82.0 109.0 05:51:42 INFO - PID 4186 | 05:51:42 INFO - PID 4186 | [#5] imaging-gaussian-blur Cycles:10 Average:114.30 Median:114.00 stddev:0.48 (0.4%) stddev-sans-first:0.44 05:51:42 INFO - PID 4186 | Values: 115.0 114.0 114.0 115.0 114.0 114.0 114.0 115.0 114.0 114.0 05:51:42 INFO - PID 4186 | 05:51:42 INFO - PID 4186 | [#6] imaging-darkroom Cycles:10 Average:150.80 Median:151.00 stddev:0.63 (0.4%) stddev-sans-first:0.67 05:51:42 INFO - PID 4186 | Values: 151.0 150.0 151.0 151.0 151.0 150.0 151.0 150.0 152.0 151.0 05:51:42 INFO - PID 4186 | 05:51:42 INFO - PID 4186 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:94.50 stddev:1.55 (1.6%) stddev-sans-first:0.50 05:51:42 INFO - PID 4186 | Values: 99.0 95.0 94.0 94.0 94.0 95.0 94.0 94.0 95.0 94.0 05:51:42 INFO - PID 4186 | 05:51:42 INFO - PID 4186 | [#8] json-parse-financial Cycles:10 Average:56.90 Median:57.50 stddev:1.10 (1.9%) stddev-sans-first:1.09 05:51:42 INFO - PID 4186 | Values: 58.0 55.0 56.0 57.0 56.0 56.0 58.0 58.0 57.0 58.0 05:51:42 INFO - PID 4186 | 05:51:42 INFO - PID 4186 | [#9] json-stringify-tinderbox Cycles:10 Average:56.30 Median:56.00 stddev:1.06 (1.9%) stddev-sans-first:1.09 05:51:42 INFO - PID 4186 | Values: 57.0 56.0 56.0 55.0 56.0 59.0 56.0 56.0 56.0 56.0 05:51:42 INFO - PID 4186 | 05:51:42 INFO - PID 4186 | [#10] stanford-crypto-aes Cycles:10 Average:91.00 Median:87.50 stddev:11.99 (13.7%) stddev-sans-first:12.58 05:51:42 INFO - PID 4186 | Values: 86.0 88.0 88.0 87.0 86.0 88.0 87.0 89.0 125.0 86.0 05:51:42 INFO - PID 4186 | 05:51:42 INFO - PID 4186 | [#11] stanford-crypto-ccm Cycles:10 Average:136.70 Median:137.00 stddev:5.29 (3.9%) stddev-sans-first:5.58 05:51:42 INFO - PID 4186 | Values: 135.0 132.0 133.0 139.0 132.0 137.0 137.0 138.0 134.0 150.0 05:51:42 INFO - PID 4186 | 05:51:42 INFO - PID 4186 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:197.90 Median:197.50 stddev:2.33 (1.2%) stddev-sans-first:1.94 05:51:42 INFO - PID 4186 | Values: 202.0 198.0 197.0 195.0 196.0 200.0 197.0 197.0 201.0 196.0 05:51:42 INFO - PID 4186 | 05:51:42 INFO - PID 4186 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:74.80 Median:75.00 stddev:2.97 (4.0%) stddev-sans-first:3.12 05:51:42 INFO - PID 4186 | Values: 76.0 76.0 74.0 73.0 72.0 73.0 76.0 82.0 74.0 72.0 05:51:42 INFO - PID 4186 | -------- Summary: end -------- 05:51:42 INFO - PID 4186 | 05:51:43 INFO - TEST-INFO | 4186: exit 0 05:51:43 INFO - TEST-OK | kraken | took 92888ms 05:51:43 INFO - SUITE-END | took 1242s 05:51:44 INFO - Completed test suite (00:20:42) 05:51:44 INFO - javascript benchmark 05:51:44 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6768.687209678062, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2738.137486691692, 2738.972610273899, 2763.240108970033, 2776.7917406194542, 2777.055801027651, 5153.510416510426, 5283.365996080475, 5304.814331498398, 5320.388155362135, 5347.35831700196, 5272.578193744501, 5284.2073688946675, 5288.497592728694, 5386.596005299599, 5392.973035134819, 4454.086912183011, 4669.859904202863, 4687.179743544874, 4725.503822098682, 4762.857114286559, 4794.664373493857, 4809.855704328876, 4829.439240689325, 4845.951540484603, 4865.245886887538, 4642.210824159901, 4643.303504474356, 4696.718196908162, 4759.762011899391, 4790.161721698689, 4774.092922344744, 4782.0, 4803.063402636487, 4814.975925120387, 4823.252395878644, 4729.172394830891, 4729.219678753002, 4740.07568524138, 4744.5492678195515, 4755.881102972418, 5157.277981082614, 5320.574354051667, 5324.8136315228785, 5346.117890548055, 5351.518363347279, 5653.802116925888, 5688.97155514224, 5765.509931655814, 5775.480206781368, 5776.33572139201, 5802.97098514509, 5808.12878068289, 5817.0983497557945, 5823.708814559255, 5862.237909071836, 5399.568034557226, 5403.675779453245, 5408.215808707715, 5412.945870541244, 5416.83749487516, 5734.05388110957, 5811.535077193815, 5828.912566311508, 5906.0, 5948.524118070544, 5649.830505084854, 5673.886522269531, 5683.204351390808, 5712.885742285131, 5721.828345149569, 5633.521150702154, 5734.426557344233, 5736.913946290809, 5739.282589676291, 5743.827685169452, 5530.889382212334, 5591.608587398843, 5711.343195532484, 5733.025385684444, 5734.799282025109, 5669.858253543612, 5706.115552089433, 5731.656100633975, 5748.626339287933, 5767.480926716532, 4675.275332323496, 4678.087772884323, 4696.365990591295, 4698.130845793539, 4735.763211839394, 3948.0, 4046.4537287466405, 4060.959390406058, 4061.8578349757618, 4096.938545921814, 4789.664723469394, 4832.0, 4871.098846713369, 4875.780589873464, 4876.926846097312, 5769.163471296639, 5770.509506691894, 5786.913196302059, 5794.21778059965, 5830.854228644318, 4872.634552408513, 4875.658703890765, 4880.682755620945, 4897.3878265216845, 4945.455999840086, 4929.06347793918, 4940.8764780880765, 4992.525710057539, 5038.974805125951, 5064.949350506521, 5423.783048678167, 5425.077736784677, 5452.372977107683, 5478.123500239943, 5492.835214943558, 5609.663420194802, 5657.858553536194, 5682.9431705684065, 5791.305043394819, 5805.651660900359, 5313.521783039545, 5377.166539186433, 5390.083685773349, 5394.460553944574, 5399.920015996738, 5588.497035266683, 5689.26039614864, 5697.287839020122, 5703.429657034263, 5739.540836733135, 5640.689762062962, 5679.091345384719, 5708.885822283448, 5712.6286791358425, 5763.02028655138, 5606.635568688022, 5618.2134501170685, 5627.127795191588, 5656.717164141859, 5674.574406919415, 5604.3835178131185, 5613.186088017296, 5613.775448981995, 5614.943850561605, 5616.775328986795, 5307.548858347083, 5378.112611419072, 5451.64564303319, 5506.834794956158, 5551.8889622208135, 5664.575156863334, 5665.036943719495, 5666.9716651416475, 5669.886602268014, 5701.543876489954, 5430.13117901134, 5452.100403433389, 5457.781688732565, 5465.398806131402, 5467.316585426822], "value": 5196.233025783402, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [705.8588282343529, 754.0574282147315, 768.2087449926576, 1101.1631160318157, 1105.9391733454656, 32447.351052978956, 32925.83537082317, 33028.17429564256, 33066.50400243995, 33113.0, 34045.82977085111, 34194.0, 34402.0, 34437.48343774845, 34529.0, 6651.135352404181, 6770.559913605624, 6793.252742198354, 6912.4470042396615, 7060.5763654180655, 6229.034499652538, 6233.875322493547, 6239.594426362295, 6239.65681887496, 6241.157443745082, 6215.627062376272, 6251.843703907393, 6254.968725156368, 6257.593256438339, 6277.874442511147, 6208.161898143738, 6219.098230756537, 6235.0, 6235.625862448268, 6244.875102497947, 6748.696308666122, 6763.12079429671, 6779.389854913032, 6789.796306110825, 6817.5568588042115, 31450.0, 31777.682223177933, 31830.681693183004, 31835.52246716301, 31847.681523184703, 2756.4073724149202, 2782.4574208029444, 2782.874770635326, 2786.0, 2786.024891288033, 24929.626055609, 25115.0, 25166.0, 25180.24459266225, 25184.748152518423, 2920.0, 2946.8526573671447, 2960.5115155999233, 2961.851907404621, 2977.955330670042, 121760.39119804432, 122060.38969805183, 131560.34219828935, 138875.0, 140140.0, 38891.22217555633, 39101.0, 39102.41346379807, 39152.41271380932, 39169.41245881314, 40239.39640905389, 40515.0, 40594.59405405908, 40610.79694601508, 43852.3422148668, 11344.716382090513, 11436.142289328334, 11453.770924581628, 11460.484278207501, 11461.942690286494, 8846.15961483658, 8861.778455538662, 8866.822663546693, 8877.156670116328, 8933.955330223438, 12869.0, 12881.935590321988, 12883.613491595268, 12908.0, 12929.870701293055, 5283.181106928432, 5308.150695888639, 5346.492083252085, 5390.326209223847, 5391.625135590478, 864.3733293362262, 905.1310741688053, 916.5921165081475, 916.6974898283551, 935.5976929920064, 20671.793282067287, 21233.78766212318, 21269.255576054762, 21370.893145534483, 21668.45828854291, 972.4554249620236, 980.7793246519476, 986.7434467038622, 1006.7684432580547, 1007.7027276953316, 11125.276857004268, 11126.833097503544, 11311.208215425006, 11325.830112548318, 11406.828897566544, 172432.13783931252, 172488.0, 172617.0, 173036.1348193251, 173894.0, 41131.38302925458, 41178.79410602928, 41420.792896035324, 41433.1713365737, 41573.1685366297, 1181.3620644851856, 1211.716248965314, 1221.6090850927617, 1224.9326287054298, 1231.0213380362634, 20217.494562635464, 20474.0, 21008.369748907557, 21057.684134738298, 21283.148674052863, 29616.111516654535, 29633.851830740707, 29818.254543636584, 29848.25379365533, 29949.85025074861, 147207.26396368377, 147914.0, 148339.0, 148364.0, 148495.0, 28918.42163156767, 29381.265468362606, 29422.411551769274, 29707.257318567208, 29991.0, 34802.82598586991, 34839.129021773646, 35932.46101308535, 36134.27731445304, 36739.63260367362, 27027.59458608083, 27223.455530888874, 27247.31881702894, 27251.318717032234, 28033.299167520974, 22325.888370558045, 22455.32634020982, 22455.88772056129, 22524.774752252266, 28590.571141433313, 30867.2283192913, 31630.683693162773, 31777.20556986094, 31997.520037198996, 32111.67888321087, 26830.731692682824, 27742.306442339104, 27819.860900695367, 27865.721342786313, 28005.859970700018, 20105.6984145235, 22385.44036399038, 22524.774752252924, 22550.661740073585, 22580.774192257868], "value": 14116.857004191112, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [402.4607026584378, 410.81923953460455, 424.2829617945671, 424.41854659117007, 437.86645073252663, 13121.606351809438, 13298.13562118464, 17729.556761080963, 17739.37912173074, 17775.37786177484, 16118.7582186267, 16572.917135414336, 16739.748903766424, 16766.41317553886, 16799.748003779954, 5527.585431092674, 5675.489205971462, 5715.0855863061915, 5723.742431590588, 5725.742341594639, 5534.640248383862, 5582.302212223472, 5587.217789509452, 5613.46672066153, 5627.437256274381, 5578.330600327967, 5587.7485513152005, 5587.832365029035, 5588.692621905793, 5604.691741954191, 5106.259592359106, 5287.9424115176735, 5312.973435132838, 5327.907778905315, 5578.24693666356, 4804.183288840905, 4843.055604157191, 4845.030993801254, 4846.5880400166025, 4850.393700787402, 22379.0, 22667.31998040045, 22738.77261227383, 22758.317250482512, 22760.975756091015, 1610.3397606981082, 1657.767912492252, 1661.534770264328, 1664.1845495707016, 1668.966620667592, 14811.407543698238, 15055.924720376437, 15059.774103388458, 15306.846931530654, 15397.076175429398, 2076.927307544229, 2090.822280106193, 2098.034903944172, 2129.9041543130597, 2149.322963266566, 101340.49329753304, 101858.0, 103569.48215258951, 104896.47551762192, 105311.0, 10666.626668066581, 10976.0, 11026.944865275782, 11207.71980700489, 11559.190856639954, 15916.76124858128, 15957.840421595636, 15960.840391595935, 15981.760273595906, 16017.43938962154, 7738.2261773822165, 7951.761447156595, 7971.123176450586, 8038.477498962548, 8046.718364857202, 7370.189279179286, 7375.0, 7402.407807375397, 7473.140588832245, 7489.138749043821, 7336.596487193149, 7352.963235183897, 7444.404447644176, 7474.626268686653, 7563.9621801891735, 2044.808143306246, 2049.6515592349338, 2090.0, 2124.5963266979224, 2168.7072245247005, 826.6321486938375, 867.6355930509201, 888.9066648001996, 904.977375565603, 912.2747415804452, 17504.0, 17583.73624395635, 17722.734158987627, 17989.640207195782, 18010.099495025195, 871.9912800872037, 879.1955360844884, 882.3294296334703, 886.4504007515382, 910.4537277633367, 9616.95191524038, 9637.614495420245, 9653.951730241304, 9999.550020249106, 10117.848232276521, 339400.0, 347971.0, 349585.0, 349687.0, 350959.0, 81343.59328203321, 81627.0, 82939.58530207431, 83699.16300836914, 84106.0, 998.8601595776597, 1021.4228960637216, 1052.6999805055675, 1054.5939813171983, 1062.2511129653576, 15249.771253431429, 15437.614059648598, 15733.370665173265, 15892.841071589137, 16174.191290435667, 41852.0, 42048.36927446152, 42101.57898421099, 43242.13515729605, 43522.12955740931, 52011.21983170331, 52153.73923130512, 52156.73921630368, 52241.7387913058, 53058.4694153069, 9474.621015159317, 9475.952620236854, 9581.185599224144, 9754.463504507321, 9765.169960553432, 15347.923260383626, 16132.354705811636, 16388.26252818602, 16805.41181058657, 16974.0, 12585.622431327074, 12644.936775316064, 12695.238285702888, 13770.31148442594, 13819.654508637364, 12071.879281207075, 12388.628341149419, 12514.18657787241, 12548.874511254771, 12600.369981501071, 12816.231026138461, 12919.354032298535, 12927.224366538037, 14074.577762667137, 14122.082064666174, 9605.951970240105, 9646.228301735704, 9735.756606084904, 9738.269629777653, 9750.902490974999, 13224.735505289647, 13310.933445332712, 13355.131916425402, 13355.53255636048, 13383.53157639478], "value": 9265.226490690104, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1265.3609926986871, 1316.1116246533588, 1316.9802452963202, 1327.396034804164, 1328.5018118205667, 10058.798824023515, 10311.43287119208, 10509.369437833735, 10511.52698128584, 10947.781044379108, 10464.52909619067, 10593.73515662107, 10608.310459820126, 10652.893471065307, 10662.733431664212, 1975.565375617369, 2013.3355992522506, 2014.3654748754168, 2014.6172227276843, 2022.0496366707698, 1953.687410014398, 2008.9196432142696, 2011.1050582490798, 2017.788132246115, 2023.5952809438097, 1974.2004488182238, 1992.3226103124935, 2002.0690378973775, 2012.034223572686, 2012.7987201279902, 1954.921803127873, 1963.7643482782157, 1964.489232799468, 1965.2139144342234, 1966.016991504248, 1909.885406875578, 1921.9231230750754, 1971.2016633263552, 2056.6709326507835, 2062.0308455026116, 10438.321509101885, 10537.315074520131, 10539.0, 10547.525361358757, 10552.261341706084, 5344.412114667383, 5539.556835453154, 5541.889162216773, 5542.168674698787, 5545.944540554624, 3066.5400189971683, 3194.952075718866, 3224.3873664004, 3234.96765032349, 3250.0737289872272, 1011.4942528735633, 1014.9949250253701, 1044.853720479126, 1055.2824079625852, 1083.9783204335947, 15512.14683192424, 16006.679866402723, 16175.757363639555, 16195.595110122224, 16232.107234102119, 4603.263477843596, 4644.883877903079, 4777.307290442866, 4808.0, 4824.421069471686, 11381.317120972768, 11482.540698372139, 11514.251573647685, 11547.942260288813, 11561.76876462466, 5317.1492561190025, 5407.540359069444, 5419.187121931742, 5424.538914192338, 5425.104857698515, 4797.832075877328, 4869.732164730974, 4881.096997055556, 4883.02339532095, 4886.364772579542, 3966.4446977423186, 3992.1416895367056, 4050.4734384529825, 4069.4302797608357, 4075.49056367954, 1061.7239517725448, 1066.0618655583037, 1073.3184427888348, 1077.9407132607782, 1082.5723839083519, 648.3937518420198, 673.6800019990563, 686.7767975408012, 693.930606939302, 698.91263592051, 5404.621676482609, 5554.666719996813, 5597.580181486404, 5653.265075540236, 5734.082546792493, 491.5993465325748, 495.0000997984052, 495.15081634996153, 509.15480302698086, 509.9311592934906, 3311.569495965509, 3889.9611003890163, 3920.862769803043, 3942.9605703943166, 4075.918481630351, 12991.870081299066, 13059.608211753473, 13397.66505837362, 13410.798838017437, 13540.322983850769, 12958.481471522551, 13317.400716967759, 13492.0, 13555.051146419853, 13576.253306068262, 7362.705491780269, 7426.962865185639, 7534.397248220129, 7550.093988721389, 7618.657160427794, 5485.698286594116, 5589.916151257653, 5735.913961290667, 5874.676892770939, 5969.403059693996, 12085.637430877088, 12339.07456940715, 12382.885540301417, 12493.812592810933, 12515.249085054926, 12629.11596188258, 12696.619101426972, 12876.0, 12936.870631293566, 12947.417366218731, 8270.297024752963, 8431.873521897054, 8449.02836173848, 8465.407421480437, 8483.74548763538, 9908.108270255712, 10021.599136034478, 10022.899771002196, 10023.198144148597, 10030.348027378197, 8259.256666900008, 8355.331573474228, 8593.269572086192, 8660.004099528383, 8677.522736249566, 7922.564258965812, 7978.920210797818, 8028.237317454832, 8033.517988920684, 8105.148959359418, 7672.961635192011, 7808.258215469521, 7810.0, 7816.452848300792, 7836.686532538634, 5328.62699611039, 5334.51989320963, 5398.946010540001, 5441.891162176814, 5667.149927510906, 5087.3386459759995, 5120.257562653469, 5171.0, 5333.839984800462, 5352.437994010573], "value": 4638.146718905007, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [352.140776505327, 356.67186188706404, 357.2230398882431, 357.85864583489507, 361.6239111324222, 5361.731913404334, 5561.888762224753, 5606.523445507131, 5617.8033768818095, 5646.322441307038, 5352.57179425645, 5423.972880135594, 5431.538319242869, 5432.538234250083, 5439.265699130626, 4062.4921884764403, 4067.4712287402594, 4095.365218391139, 4104.220198162339, 4105.117399759051, 4094.6110119538744, 4097.856575019875, 4102.640981435671, 4103.610157035077, 4105.651019663317, 4069.3489041753323, 4086.1010577673014, 4086.9182616347803, 4096.877093687194, 4106.466159399274, 4068.735532190413, 4081.897952551195, 4085.3054980653064, 4086.570910054461, 4104.938425923614, 3585.3904836177912, 3593.4609808528667, 3593.6406359364114, 3602.837872295753, 3608.7654302470255, 5324.680519168863, 5350.705711185883, 5357.785688572452, 5367.597430192751, 5382.9730851345885, 4778.661974647104, 4780.306855505932, 4803.0874133914795, 4810.158222311082, 4820.528699925575, 5757.395473475309, 5758.9633865904125, 5770.221020162308, 5775.8556036099435, 5786.47921687046, 3970.801459927021, 3977.840886364542, 3982.362821948503, 4005.819738111792, 4028.6575641070544, 5747.942520574783, 6108.5418593605655, 6158.7228574714245, 6198.2252218472695, 6204.007358822611, 4018.2566225248424, 4030.3954406839207, 4039.414284928669, 4039.636432721069, 4059.7361171523758, 4093.2222877653153, 4095.0990782027907, 4117.0, 4120.846163074344, 4126.463559737275, 4632.374629425052, 4720.811167553328, 4733.810647574127, 4754.95245047552, 4773.522647735199, 5750.769969201268, 5786.971065144648, 5803.448672376117, 5806.693493963824, 5828.883422331614, 1422.9786553201711, 1425.187643043476, 1429.385364293343, 1431.9546730886302, 1431.992840035793, 916.4592890194817, 962.0667952086465, 966.087047739879, 969.7769513012047, 972.5040229482873, 5045.369328833895, 5053.646244762831, 5054.115529782273, 5056.595472362203, 5076.44159142494, 5978.551608629283, 5982.4017598239825, 5996.841137190608, 6019.277686677539, 6027.186329845415, 4985.626078044161, 5031.144705400091, 5032.949670503322, 5038.093143234253, 5040.974795126001, 3156.2425017995974, 3168.8574014169417, 3172.984135079356, 3175.0, 3180.2367431816197, 5606.355269144019, 5618.185363122325, 5622.072358060956, 5629.155626656035, 5674.659520428788, 6069.726862291208, 6129.662868542273, 6133.815985520441, 6151.6001459904965, 6162.952298109332, 5613.635113717677, 5642.689652069093, 5648.15277708347, 5666.688332141772, 5682.488576028178, 5986.4013598639785, 5989.8203053908455, 5998.160257563857, 6000.489958353589, 6002.589391492908, 5870.5010074144175, 5876.588638795243, 5878.617889837147, 5895.145203945318, 5912.113183022581, 5303.6663867898005, 5545.556355491471, 5621.184928185472, 5626.127950167731, 5639.605227634026, 4075.531313898821, 4091.713580049487, 4104.199681062164, 4107.158032603369, 4112.444819949268, 5828.94171058284, 5984.431479009487, 5997.670128142994, 6000.339962604023, 6006.459418652343, 5786.566007549366, 5791.391903850035, 5806.925718742046, 5838.708064596838, 5839.5036421904615, 5822.737976791139, 5841.737121829613, 5849.795257165979, 5851.1223316502865, 5857.677827719516, 5724.771009159587, 5749.13762935563, 5752.884942301214, 5755.942440575541, 5758.798442054508, 5838.474537291664, 5846.216903844198, 5855.765769369177, 5872.060470324727, 5900.763969441175, 5632.5212356950115, 5711.857203569944, 5733.741981610921, 5750.5112065474905, 5763.394843541536], "value": 4314.100189032911, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [743.3867059675762, 749.1609397474829, 764.7399884039426, 769.6267310354478, 772.6484449575444, 11119.221654484189, 11685.824712629317, 12579.0, 13531.458741650335, 13567.389467473975, 13954.0, 14141.292935353216, 14338.928305358484, 14383.496577619786, 14447.422103115889, 870.5995242188585, 890.7416849113749, 896.090468174803, 896.2874514760748, 896.3277541843618, 826.3802148388709, 898.6674930275807, 899.190728344492, 900.4417261297972, 901.6303315640589, 943.0522325063301, 957.34421920984, 957.7461972577272, 959.0457494792691, 960.9807803843919, 943.3820847345, 949.6059135458777, 950.8668786369914, 954.1651055326624, 958.6453012385392, 693.1681981622073, 696.6830092308038, 696.7143471176844, 698.3958875572644, 698.4761428928304, 13174.86825131746, 13194.538191163263, 13220.272884991322, 13221.669458263525, 13254.46982120714, 15077.623059423493, 15446.0, 15954.202289885576, 16006.119663418507, 16040.518784436486, 12094.576689815814, 12101.273923564615, 12185.0, 12247.203931744409, 12260.81608775869, 3048.039867441771, 3068.140920542252, 3077.692230776927, 3081.3837232553356, 3083.8612262448246, 82528.58735706343, 83921.16078839256, 84175.57912210461, 84600.0, 85052.57473712653, 11666.70833229176, 11732.178747487764, 11883.524659013716, 11886.0, 12000.819987700192, 22440.551188976457, 22910.885445573, 23304.65043024356, 23343.0, 23349.0, 6134.04922237054, 6153.323134455206, 6170.845728856814, 6199.225096862892, 6208.255009398811, 2856.957145642817, 2939.426811771684, 3044.071558174778, 3059.2351912021995, 3065.908022759321, 3425.6060553036223, 3939.2515422069714, 4205.474315710536, 4205.831766729358, 4217.030083080908, 765.670761572518, 776.4836383804707, 787.1262898183012, 796.366888323784, 801.0907619851511, 589.5519405252039, 601.8886505996404, 603.4508597176548, 617.0867116667267, 627.2065836716557, 9949.850752238723, 10400.791984160274, 10404.947975260227, 10491.737706557396, 10597.311174773615, 572.8882867840814, 581.8050952930731, 582.5892745614332, 592.5259792166249, 602.1028667285713, 4425.424694789656, 4628.213203755369, 4665.2768820832825, 4717.716936983792, 4826.396700412449, 86246.56876715577, 86384.0, 86649.0, 87321.0, 88557.11442885488, 77046.0, 78244.0, 78758.0, 79095.0, 79132.20867791248, 65806.67096664582, 66375.66812166006, 66520.33479665239, 66830.3316966824, 67743.32256677469, 8887.644494220418, 9151.084891510796, 9353.906460935576, 9513.191378732885, 9651.0, 29475.0, 30038.24904377408, 30247.243818904702, 30263.0, 30804.53793193059, 36823.26353472969, 37423.25153496969, 37423.625763743104, 37872.0, 38211.0, 11575.88424115748, 11900.107491938312, 13389.933050335076, 14231.07498012626, 14411.207383594003, 15248.618784530476, 15962.521124366287, 15979.280932357839, 16023.278952447401, 16167.029978201346, 14022.649433763829, 14100.36548355306, 14151.080179788692, 14252.786208206679, 14320.06919550226, 14237.64405889861, 14337.139771613736, 14485.637859053186, 14649.26753662334, 14661.340239689453, 13239.0, 13306.268155251553, 13831.86168138346, 13895.72208555803, 13971.510997115052, 9835.016498350107, 10261.846072308772, 10336.844947325946, 10617.946910265398, 11132.888671113185, 10040.949795251268, 10916.945415272872, 10935.45322733876, 10984.231103822656, 11053.226274160732], "value": 7070.942901004044, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1553.1000000000001, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 112.0, 112.0, 111.0, 111.0, 112.0, 112.0, 112.0, 112.0, 112.0], "value": 111.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 123.0, 124.0, 173.0, 123.0, 124.0, 124.0, 124.0, 148.0, 124.0], "value": 133.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 164.0, 163.0, 165.0, 168.0, 172.0, 169.0, 163.0, 163.0, 162.0], "value": 165.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 79.0, 74.0, 110.0, 75.0, 74.0, 75.0, 75.0, 96.0, 75.0], "value": 80.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 98.0, 84.0, 83.0, 85.0, 97.0, 84.0, 82.0, 109.0], "value": 88.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 114.0, 114.0, 115.0, 114.0, 114.0, 114.0, 115.0, 114.0, 114.0], "value": 114.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 150.0, 151.0, 151.0, 151.0, 150.0, 151.0, 150.0, 152.0, 151.0], "value": 150.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 95.0, 94.0, 94.0, 94.0, 95.0, 94.0, 94.0, 95.0, 94.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 55.0, 56.0, 57.0, 56.0, 56.0, 58.0, 58.0, 57.0, 58.0], "value": 56.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 56.0, 56.0, 55.0, 56.0, 59.0, 56.0, 56.0, 56.0, 56.0], "value": 56.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 88.0, 88.0, 87.0, 86.0, 88.0, 87.0, 89.0, 125.0, 86.0], "value": 91.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 132.0, 133.0, 139.0, 132.0, 137.0, 137.0, 138.0, 134.0, 150.0], "value": 136.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [202.0, 198.0, 197.0, 195.0, 196.0, 200.0, 197.0, 197.0, 201.0, 196.0], "value": 197.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 74.0, 73.0, 72.0, 73.0, 76.0, 82.0, 74.0, 72.0], "value": 74.8, "unit": "score"}]}]} 05:51:44 INFO - Return code: 0 05:51:44 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:51:44 INFO - # TBPL SUCCESS # 05:51:44 INFO - Running post-action listener: _resource_record_post_action 05:51:44 INFO - [mozharness: 2017-06-01 12:51:44.406378Z] Finished run-tests step (success) 05:51:44 INFO - Running post-run listener: _resource_record_post_run 05:51:44 INFO - Total resource usage - Wall time: 1259s; CPU: 13.0%; Read bytes: 8593408; Write bytes: 411447296; Read time: 3484; Write time: 457904 05:51:44 INFO - TinderboxPrint: CPU usage
12.7% 05:51:44 INFO - TinderboxPrint: I/O read bytes / time
8,593,408 / 3,484 05:51:44 INFO - TinderboxPrint: I/O write bytes / time
411,447,296 / 457,904 05:51:44 INFO - TinderboxPrint: CPU idle
8,777.4 (87.3%) 05:51:44 INFO - TinderboxPrint: CPU user
1,216.2 (12.1%) 05:51:44 INFO - TinderboxPrint: Swap in / out
0 / 0 05:51:44 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 4096; Write bytes: 102666240; Read time: 24; Write time: 104068 05:51:44 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 05:51:44 INFO - run-tests - Wall time: 1243s; CPU: 13.0%; Read bytes: 8589312; Write bytes: 274956288; Read time: 3460; Write time: 341904 05:51:45 INFO - Running post-run listener: _upload_blobber_files 05:51:45 INFO - Blob upload gear active. 05:51:45 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:51:45 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:51:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:51:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:51:45 INFO - (blobuploader) - INFO - Open directory for files ... 05:51:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:51:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:51:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:51:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:51:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:51:46 INFO - (blobuploader) - INFO - Done attempting. 05:51:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:51:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:51:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:51:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:51:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:51:47 INFO - (blobuploader) - INFO - Done attempting. 05:51:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:51:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:51:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:51:51 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:51:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:51:51 INFO - (blobuploader) - INFO - Done attempting. 05:51:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 05:51:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:51:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:51:51 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 05:51:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:51:51 INFO - (blobuploader) - INFO - Done attempting. 05:51:51 INFO - (blobuploader) - INFO - Iteration through files over. 05:51:51 INFO - Return code: 0 05:51:51 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:51:51 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:51:51 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/cab1969a8c7d5d9af7834bfeb0223683e7ad8ab9552a75e8501de5fddce38954cda5ddb650e5a7c67b38892ec41184eea1bb0873a3746c12b261d9d1b4f0850f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/650a4bc5a3eec7f07e9c74b2d5c141f1e16d7662783daf46d5b564b1a366770521868cfab46d8d89509cce7261eaeae8daef98506a8f91b55e0d62b331b66f1e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3ab6d7002f3cb8cb48b43d32264d96758e1577df7e08eb521e3fc0522d331774a1b8a064fcb868837b0a2170dc6176dd9ee33952b47ffe5ac7d317c26f8a4738", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1bc4951d22ccf5abfc0c111f7622e6205538f632b91fb51ada70dc62fe81520e505ba261544938e14419d265b9ef172025d764443acbb9d9d41d5892cd2bcfdc"} 05:51:51 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:51:51 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:51:51 INFO - Contents: 05:51:51 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/cab1969a8c7d5d9af7834bfeb0223683e7ad8ab9552a75e8501de5fddce38954cda5ddb650e5a7c67b38892ec41184eea1bb0873a3746c12b261d9d1b4f0850f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/650a4bc5a3eec7f07e9c74b2d5c141f1e16d7662783daf46d5b564b1a366770521868cfab46d8d89509cce7261eaeae8daef98506a8f91b55e0d62b331b66f1e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3ab6d7002f3cb8cb48b43d32264d96758e1577df7e08eb521e3fc0522d331774a1b8a064fcb868837b0a2170dc6176dd9ee33952b47ffe5ac7d317c26f8a4738", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1bc4951d22ccf5abfc0c111f7622e6205538f632b91fb51ada70dc62fe81520e505ba261544938e14419d265b9ef172025d764443acbb9d9d41d5892cd2bcfdc"} 05:51:51 INFO - Running post-run listener: copy_logs_to_upload_dir 05:51:51 INFO - Copying logs to upload dir... 05:51:51 INFO - mkdir: /builds/slave/test/build/upload/logs 05:51:51 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1321.914386 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 1 secs) (at 2017-06-01 05:51:52.050258) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-06-01 05:51:52.057118) ========= 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=5cf47e208febbcd81da23b2e0000026f-1496314696.278331-184849942 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-Non-PGO/sha512/cab1969a8c7d5d9af7834bfeb0223683e7ad8ab9552a75e8501de5fddce38954cda5ddb650e5a7c67b38892ec41184eea1bb0873a3746c12b261d9d1b4f0850f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/650a4bc5a3eec7f07e9c74b2d5c141f1e16d7662783daf46d5b564b1a366770521868cfab46d8d89509cce7261eaeae8daef98506a8f91b55e0d62b331b66f1e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3ab6d7002f3cb8cb48b43d32264d96758e1577df7e08eb521e3fc0522d331774a1b8a064fcb868837b0a2170dc6176dd9ee33952b47ffe5ac7d317c26f8a4738", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1bc4951d22ccf5abfc0c111f7622e6205538f632b91fb51ada70dc62fe81520e505ba261544938e14419d265b9ef172025d764443acbb9d9d41d5892cd2bcfdc"} build_url:https://queue.taskcluster.net/v1/task/JkQc7maxRUa3Rvf0G-7tsA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011154 build_url: 'https://queue.taskcluster.net/v1/task/JkQc7maxRUa3Rvf0G-7tsA/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/cab1969a8c7d5d9af7834bfeb0223683e7ad8ab9552a75e8501de5fddce38954cda5ddb650e5a7c67b38892ec41184eea1bb0873a3746c12b261d9d1b4f0850f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/650a4bc5a3eec7f07e9c74b2d5c141f1e16d7662783daf46d5b564b1a366770521868cfab46d8d89509cce7261eaeae8daef98506a8f91b55e0d62b331b66f1e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3ab6d7002f3cb8cb48b43d32264d96758e1577df7e08eb521e3fc0522d331774a1b8a064fcb868837b0a2170dc6176dd9ee33952b47ffe5ac7d317c26f8a4738", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1bc4951d22ccf5abfc0c111f7622e6205538f632b91fb51ada70dc62fe81520e505ba261544938e14419d265b9ef172025d764443acbb9d9d41d5892cd2bcfdc"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-06-01 05:51:52.080706) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-06-01 05:51:52.081018) ========= 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=5cf47e208febbcd81da23b2e0000026f-1496314696.278331-184849942 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004460 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-06-01 05:51:52.166487) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-06-01 05:51:52.168832) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-06-01 05:51:52.169135) ========= ========= Total master_lag: 0.19 =========