builder: mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s slave: talos-linux64-ix-083 starttime: 1496224766.77 results: success (0) revision: 06d83f260f410f125847e95618b6f8b9e83e9a2f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-31 02:59:26.766775) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-31 02:59:26.767316) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-31 02:59:26.767590) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-31 02:59:26.808350) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-31 02:59:26.808605) ========= 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=3297cc2eebb5444a7688c33f000001b5-1496221020.334826-633799755 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-05-31 02:59:27-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 222M=0s 2017-05-31 02:59:27 (222 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.109876 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-31 02:59:26.931200) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-31 02:59:26.931477) ========= 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=3297cc2eebb5444a7688c33f000001b5-1496221020.334826-633799755 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020619 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-31 02:59:26.980593) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-31 02:59:26.981084) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 06d83f260f410f125847e95618b6f8b9e83e9a2f --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 06d83f260f410f125847e95618b6f8b9e83e9a2f --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=3297cc2eebb5444a7688c33f000001b5-1496221020.334826-633799755 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-05-31 02:59:27,385 truncating revision to first 12 chars 2017-05-31 02:59:27,385 Setting DEBUG logging. 2017-05-31 02:59:27,386 attempt 1/10 2017-05-31 02:59:27,386 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/06d83f260f41?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-31 02:59:28,465 unpacking tar archive at: mozilla-central-06d83f260f41/testing/mozharness/ program finished with exit code 0 elapsedTime=1.367057 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-31 02:59:28.360255) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-31 02:59:28.360583) ========= script_repo_revision: 06d83f260f410f125847e95618b6f8b9e83e9a2f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-31 02:59:28.360952) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-31 02:59:28.361224) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-31 02:59:28.368585) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 56 secs) (at 2017-05-31 02:59:28.368864) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=3297cc2eebb5444a7688c33f000001b5-1496221020.334826-633799755 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:59:28 INFO - MultiFileLogger online at 20170531 02:59:28 in /builds/slave/test 02:59:28 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 02:59:28 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:59:28 INFO - {'append_to_log': False, 02:59:28 INFO - 'base_work_dir': '/builds/slave/test', 02:59:28 INFO - 'blob_upload_branch': 'Firefox', 02:59:28 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:59:28 INFO - 'branch': 'Firefox', 02:59:28 INFO - 'buildbot_json_path': 'buildprops.json', 02:59:28 INFO - 'config_files': ('talos/linux_config.py',), 02:59:28 INFO - 'default_actions': ('clobber', 02:59:28 INFO - 'read-buildbot-config', 02:59:28 INFO - 'download-and-extract', 02:59:28 INFO - 'populate-webroot', 02:59:28 INFO - 'create-virtualenv', 02:59:28 INFO - 'install', 02:59:28 INFO - 'setup-mitmproxy', 02:59:28 INFO - 'run-tests'), 02:59:28 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:59:28 INFO - 'download_minidump_stackwalk': True, 02:59:28 INFO - 'download_symbols': 'ondemand', 02:59:28 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:59:28 INFO - 'tooltool.py': '/tools/tooltool.py', 02:59:28 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:59:28 INFO - '/tools/misc-python/virtualenv.py')}, 02:59:28 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:59:28 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:59:28 INFO - 'gecko_profile': False, 02:59:28 INFO - 'gecko_profile_interval': 0, 02:59:28 INFO - 'installer_path': 'installer.exe', 02:59:28 INFO - 'log_level': 'info', 02:59:28 INFO - 'log_name': 'talos', 02:59:28 INFO - 'log_to_console': True, 02:59:28 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:59:28 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:59:28 INFO - 'opt_config_files': (), 02:59:28 INFO - 'pip_index': False, 02:59:28 INFO - 'suite': 'dromaeojs-e10s', 02:59:28 INFO - 'system_bits': '32', 02:59:28 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:59:28 INFO - 'title': 'talos-linux64-ix-083', 02:59:28 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:59:28 INFO - 'use_talos_json': True, 02:59:28 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:59:28 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:59:28 INFO - 'work_dir': 'build'} 02:59:28 INFO - [mozharness: 2017-05-31 09:59:28.869224Z] Running clobber step. 02:59:28 INFO - Running pre-action listener: _resource_record_pre_action 02:59:28 INFO - Running main action method: clobber 02:59:28 INFO - rmtree: /builds/slave/test/build 02:59:28 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:59:29 INFO - Running post-action listener: _resource_record_post_action 02:59:29 INFO - [mozharness: 2017-05-31 09:59:29.888930Z] Finished clobber step (success) 02:59:29 INFO - [mozharness: 2017-05-31 09:59:29.889031Z] Running read-buildbot-config step. 02:59:29 INFO - Running pre-action listener: _resource_record_pre_action 02:59:29 INFO - Running main action method: read_buildbot_config 02:59:29 INFO - Using buildbot properties: 02:59:29 INFO - { 02:59:29 INFO - "project": "", 02:59:29 INFO - "product": "firefox", 02:59:29 INFO - "who": "cbook@mozilla.com", 02:59:29 INFO - "installer_path": "public/build/target.tar.bz2", 02:59:29 INFO - "builddir": "mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s", 02:59:29 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 02:59:29 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo mozilla-central talos dromaeojs-e10s", 02:59:29 INFO - "stage_platform": "linux64-stylo", 02:59:29 INFO - "basedir": "/builds/slave/test", 02:59:29 INFO - "buildnumber": 123, 02:59:29 INFO - "platform": "ubuntu64_hw_stylo", 02:59:29 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 02:59:29 INFO - "slavebuilddir": "test", 02:59:29 INFO - "taskId": "fu2t5TTuRUq6iGc2LicEHg", 02:59:29 INFO - "branch": "mozilla-central", 02:59:29 INFO - "script_repo_revision": "production", 02:59:29 INFO - "revision": "06d83f260f410f125847e95618b6f8b9e83e9a2f", 02:59:29 INFO - "slavename": "talos-linux64-ix-083", 02:59:29 INFO - "repo_path": "mozilla-central" 02:59:29 INFO - } 02:59:29 INFO - Finding installer, test and symbols from parent task. 02:59:29 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/fu2t5TTuRUq6iGc2LicEHg'}, attempt #1 02:59:30 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/fu2t5TTuRUq6iGc2LicEHg'}, attempt #1 02:59:30 INFO - Task dependencies: ZPsXcz3ZRXiFbi_tli0rPA 02:59:30 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZPsXcz3ZRXiFbi_tli0rPA'}, attempt #1 02:59:31 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/ZPsXcz3ZRXiFbi_tli0rPA/artifacts/public/build/target.tar.bz2 02:59:31 INFO - Set test_url: https://queue.taskcluster.net/v1/task/ZPsXcz3ZRXiFbi_tli0rPA/artifacts/public/build/test_packages.json 02:59:31 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/ZPsXcz3ZRXiFbi_tli0rPA/artifacts/public/build/target.crashreporter-symbols.zip 02:59:31 INFO - Running post-action listener: _resource_record_post_action 02:59:31 INFO - [mozharness: 2017-05-31 09:59:31.240116Z] Finished read-buildbot-config step (success) 02:59:31 INFO - [mozharness: 2017-05-31 09:59:31.240338Z] Running download-and-extract step. 02:59:31 INFO - Running pre-action listener: _resource_record_pre_action 02:59:31 INFO - Running main action method: download_and_extract 02:59:31 INFO - mkdir: /builds/slave/test/build/tests 02:59: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')]} 02:59:31 INFO - trying https://queue.taskcluster.net/v1/task/ZPsXcz3ZRXiFbi_tli0rPA/artifacts/public/build/target.test_packages.json 02:59:31 INFO - Downloading https://queue.taskcluster.net/v1/task/ZPsXcz3ZRXiFbi_tli0rPA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 02:59:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZPsXcz3ZRXiFbi_tli0rPA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 02:59:31 INFO - Downloaded 986 bytes. 02:59:31 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 02:59:31 INFO - Using the following test package requirements: 02:59:31 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 02:59:31 INFO - u'common': [u'target.common.tests.zip'], 02:59:31 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 02:59:31 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 02:59:31 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 02:59:31 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 02:59:31 INFO - u'mozbase': [u'target.common.tests.zip'], 02:59:31 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 02:59:31 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 02:59:31 INFO - u'web-platform': [u'target.common.tests.zip', 02:59:31 INFO - u'target.web-platform.tests.zip'], 02:59:31 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 02:59:31 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 02:59:31 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ZPsXcz3ZRXiFbi_tli0rPA/artifacts/public/build/target.common.tests.zip 02:59:31 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZPsXcz3ZRXiFbi_tli0rPA/artifacts/public/build/target.common.tests.zip'}, attempt #1 02:59:31 INFO - Fetch https://queue.taskcluster.net/v1/task/ZPsXcz3ZRXiFbi_tli0rPA/artifacts/public/build/target.common.tests.zip into memory 02:59:32 INFO - Content-Length response header: 63526654 02:59:32 INFO - Bytes received: 63526654 02:59:43 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 02:59:43 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ZPsXcz3ZRXiFbi_tli0rPA/artifacts/public/build/target.common.tests.zip 02:59:43 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZPsXcz3ZRXiFbi_tli0rPA/artifacts/public/build/target.common.tests.zip'}, attempt #1 02:59:43 INFO - Fetch https://queue.taskcluster.net/v1/task/ZPsXcz3ZRXiFbi_tli0rPA/artifacts/public/build/target.common.tests.zip into memory 02:59:45 INFO - Content-Length response header: 63526654 02:59:45 INFO - Bytes received: 63526654 02:59:57 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ZPsXcz3ZRXiFbi_tli0rPA/artifacts/public/build/target.talos.tests.zip 02:59:57 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZPsXcz3ZRXiFbi_tli0rPA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 02:59:57 INFO - Fetch https://queue.taskcluster.net/v1/task/ZPsXcz3ZRXiFbi_tli0rPA/artifacts/public/build/target.talos.tests.zip into memory 02:59:58 INFO - Content-Length response header: 14447425 02:59:58 INFO - Bytes received: 14447425 02:59:58 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')]} 02:59:58 INFO - trying https://queue.taskcluster.net/v1/task/ZPsXcz3ZRXiFbi_tli0rPA/artifacts/public/build/target.tar.bz2 02:59:58 INFO - Downloading https://queue.taskcluster.net/v1/task/ZPsXcz3ZRXiFbi_tli0rPA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 02:59:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZPsXcz3ZRXiFbi_tli0rPA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 03:00:00 INFO - Downloaded 55912076 bytes. 03:00:00 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ZPsXcz3ZRXiFbi_tli0rPA/artifacts/public/build/target.tar.bz2 03:00:00 INFO - mkdir: /builds/slave/test/properties 03:00:00 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:00:00 INFO - Writing to file /builds/slave/test/properties/build_url 03:00:00 INFO - Contents: 03:00:00 INFO - build_url:https://queue.taskcluster.net/v1/task/ZPsXcz3ZRXiFbi_tli0rPA/artifacts/public/build/target.tar.bz2 03:00:00 INFO - Running post-action listener: _resource_record_post_action 03:00:00 INFO - Running post-action listener: set_extra_try_arguments 03:00:00 INFO - [mozharness: 2017-05-31 10:00:00.565204Z] Finished download-and-extract step (success) 03:00:00 INFO - [mozharness: 2017-05-31 10:00:00.565468Z] Running populate-webroot step. 03:00:00 INFO - Running pre-action listener: _resource_record_pre_action 03:00:00 INFO - Running main action method: populate_webroot 03:00:00 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:00:00 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:00:00 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:00:00 INFO - '--tppagecycles', 03:00:00 INFO - '7'], 03:00:00 INFO - 'tests': ['tsvgm']}}, 03:00:00 INFO - 'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:00:00 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:00:00 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:00:00 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:00:00 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 03:00:00 INFO - 'talos_options': ['--disable-e10s'], 03:00:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:00:00 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 03:00:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:00:00 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 03:00:00 INFO - 'talos_options': ['--disable-e10s'], 03:00:00 INFO - 'tests': ['damp', 'tps']}, 03:00:00 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 03:00:00 INFO - 'tests': ['damp', 'tps']}, 03:00:00 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:00:00 INFO - 'tests': ['dromaeo_dom']}, 03:00:00 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:00:00 INFO - 'g4': {'talos_options': ['--disable-e10s'], 03:00:00 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 03:00:00 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 03:00:00 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 03:00:00 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 03:00:00 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:00:00 INFO - 'tests': ['a11yr', 03:00:00 INFO - 'ts_paint', 03:00:00 INFO - 'tpaint', 03:00:00 INFO - 'sessionrestore', 03:00:00 INFO - 'sessionrestore_no_auto_restore', 03:00:00 INFO - 'tabpaint']}, 03:00:00 INFO - 'other-e10s': {'tests': ['a11yr', 03:00:00 INFO - 'ts_paint', 03:00:00 INFO - 'tpaint', 03:00:00 INFO - 'sessionrestore', 03:00:00 INFO - 'sessionrestore_no_auto_restore', 03:00:00 INFO - 'tabpaint']}, 03:00:00 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:00:00 INFO - 'ts_paint', 03:00:00 INFO - 'tpaint', 03:00:00 INFO - 'sessionrestore', 03:00:00 INFO - 'sessionrestore_no_auto_restore', 03:00:00 INFO - 'tabpaint']}, 03:00:00 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:00:00 INFO - 'ts_paint', 03:00:00 INFO - 'tpaint', 03:00:00 INFO - 'sessionrestore', 03:00:00 INFO - 'sessionrestore_no_auto_restore', 03:00:00 INFO - 'tabpaint']}, 03:00:00 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:00:00 INFO - 'tests': ['a11yr', 03:00:00 INFO - 'ts_paint', 03:00:00 INFO - 'tpaint', 03:00:00 INFO - 'sessionrestore', 03:00:00 INFO - 'sessionrestore_no_auto_restore', 03:00:00 INFO - 'tabpaint']}, 03:00:00 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:00:00 INFO - 'tests': ['a11yr', 03:00:00 INFO - 'ts_paint', 03:00:00 INFO - 'tpaint', 03:00:00 INFO - 'sessionrestore', 03:00:00 INFO - 'sessionrestore_no_auto_restore', 03:00:00 INFO - 'tabpaint']}, 03:00:00 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 03:00:00 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 03:00:00 INFO - 'bloom_basic_ref']}, 03:00:00 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set.zip', 03:00:00 INFO - 'talos_options': ['--mitmproxy', 03:00:00 INFO - 'mitmproxy-recording-1.mp', 03:00:00 INFO - '--firstNonBlankPaint'], 03:00:00 INFO - 'tests': ['Quantum_1']}, 03:00:00 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:00:00 INFO - 'tests': ['tsvgx', 03:00:00 INFO - 'tsvgr_opacity', 03:00:00 INFO - 'tart', 03:00:00 INFO - 'tscrollx', 03:00:00 INFO - 'cart', 03:00:00 INFO - 'tsvg_static']}, 03:00:00 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:00:00 INFO - 'tsvgr_opacity', 03:00:00 INFO - 'tart', 03:00:00 INFO - 'tscrollx', 03:00:00 INFO - 'cart', 03:00:00 INFO - 'tsvg_static']}, 03:00:00 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 03:00:00 INFO - 'talos_options': ['--disable-e10s'], 03:00:00 INFO - 'tests': ['tp5o']}, 03:00:00 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 03:00:00 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 03:00:00 INFO - 'talos_options': ['--disable-e10s', 03:00:00 INFO - '--xperf_path', 03:00:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:00:00 INFO - 'tests': ['tp5n']}, 03:00:00 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 03:00:00 INFO - 'talos_options': ['--xperf_path', 03:00:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:00:00 INFO - 'tests': ['tp5n']}}, 03:00:00 INFO - 'talos.zip': {'path': '', 03:00:00 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:00:00 INFO - Running post-action listener: _resource_record_post_action 03:00:00 INFO - [mozharness: 2017-05-31 10:00:00.584773Z] Finished populate-webroot step (success) 03:00:00 INFO - [mozharness: 2017-05-31 10:00:00.584869Z] Running create-virtualenv step. 03:00:00 INFO - Running pre-action listener: _resource_record_pre_action 03:00:00 INFO - Running main action method: create_virtualenv 03:00:00 INFO - Creating virtualenv /builds/slave/test/build/venv 03:00:00 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 03:00:00 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:00:00 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:00:00 INFO - Using real prefix '/usr' 03:00:00 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:00:01 INFO - Installing distribute.............................................................................................................................................................................................done. 03:00:03 INFO - Installing pip.................done. 03:00:03 INFO - Return code: 0 03:00:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 03:00:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 03:00:03 INFO - Reading from file tmpfile_stdout 03:00:03 INFO - Output received: 03:00:03 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) 03:00:03 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:00:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:00:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:00:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:00:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:00:03 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 0x17283b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1902a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1aa6dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aa3840>, '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 0x1aa4740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1aa4bd0>, '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': '3297cc2eebb5444a7688c33f000001b5-1496221020.334826-633799755', '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 03:00:03 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 03:00:03 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 03:00:03 INFO - Using env: {'DISPLAY': ':0', 03:00:03 INFO - 'HOME': '/home/cltbld', 03:00:03 INFO - 'LANG': 'en_US.UTF-8', 03:00:03 INFO - 'LANGUAGE': 'en_US:en', 03:00:03 INFO - 'LOGNAME': 'cltbld', 03:00:03 INFO - 'MAIL': '/var/mail/cltbld', 03:00:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:00:03 INFO - 'MOZ_NO_REMOTE': '1', 03:00:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:00:03 INFO - 'NO_EM_RESTART': '1', 03:00:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:00:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:00:03 INFO - 'PWD': '/builds/slave/test', 03:00:03 INFO - 'SHELL': '/bin/bash', 03:00:03 INFO - 'SHLVL': '1', 03:00:03 INFO - 'TERM': 'linux', 03:00:03 INFO - 'TMOUT': '86400', 03:00:03 INFO - 'USER': 'cltbld', 03:00:03 INFO - 'XDG_SESSION_COOKIE': '3297cc2eebb5444a7688c33f000001b5-1496221020.334826-633799755', 03:00:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:00:03 INFO - '_': '/tools/buildbot/bin/python'} 03:00:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:00:03 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 03:00:03 INFO - Cleaning up... 03:00:03 INFO - Return code: 0 03:00:03 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:00:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:00:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:00:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:00:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:00:03 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 0x17283b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1902a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1aa6dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aa3840>, '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 0x1aa4740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1aa4bd0>, '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': '3297cc2eebb5444a7688c33f000001b5-1496221020.334826-633799755', '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 03:00:03 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 03:00:03 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 03:00:03 INFO - Using env: {'DISPLAY': ':0', 03:00:03 INFO - 'HOME': '/home/cltbld', 03:00:03 INFO - 'LANG': 'en_US.UTF-8', 03:00:03 INFO - 'LANGUAGE': 'en_US:en', 03:00:03 INFO - 'LOGNAME': 'cltbld', 03:00:03 INFO - 'MAIL': '/var/mail/cltbld', 03:00:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:00:03 INFO - 'MOZ_NO_REMOTE': '1', 03:00:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:00:03 INFO - 'NO_EM_RESTART': '1', 03:00:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:00:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:00:03 INFO - 'PWD': '/builds/slave/test', 03:00:03 INFO - 'SHELL': '/bin/bash', 03:00:03 INFO - 'SHLVL': '1', 03:00:03 INFO - 'TERM': 'linux', 03:00:03 INFO - 'TMOUT': '86400', 03:00:03 INFO - 'USER': 'cltbld', 03:00:03 INFO - 'XDG_SESSION_COOKIE': '3297cc2eebb5444a7688c33f000001b5-1496221020.334826-633799755', 03:00:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:00:03 INFO - '_': '/tools/buildbot/bin/python'} 03:00:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:00:03 INFO - Downloading/unpacking psutil>=3.1.1 03:00:03 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 03:00:03 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 03:00:03 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 03:00:03 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 03:00:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:00:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:00:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:00:04 INFO - Installing collected packages: psutil 03:00:04 INFO - Running setup.py install for psutil 03:00:05 INFO - building 'psutil._psutil_linux' extension 03:00:05 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 03:00:05 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 03:00:05 INFO - building 'psutil._psutil_posix' extension 03:00:05 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 03:00:05 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 03:00:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:00:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:00:05 INFO - Successfully installed psutil 03:00:05 INFO - Cleaning up... 03:00:05 INFO - Return code: 0 03:00:05 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:00:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:00:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:00:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:00:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:00:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17283b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1902a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1aa6dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aa3840>, '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 0x1aa4740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1aa4bd0>, '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': '3297cc2eebb5444a7688c33f000001b5-1496221020.334826-633799755', '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 03:00:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 03:00:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 03:00:05 INFO - Using env: {'DISPLAY': ':0', 03:00:05 INFO - 'HOME': '/home/cltbld', 03:00:05 INFO - 'LANG': 'en_US.UTF-8', 03:00:05 INFO - 'LANGUAGE': 'en_US:en', 03:00:05 INFO - 'LOGNAME': 'cltbld', 03:00:05 INFO - 'MAIL': '/var/mail/cltbld', 03:00:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:00:05 INFO - 'MOZ_NO_REMOTE': '1', 03:00:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:00:05 INFO - 'NO_EM_RESTART': '1', 03:00:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:00:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:00:05 INFO - 'PWD': '/builds/slave/test', 03:00:05 INFO - 'SHELL': '/bin/bash', 03:00:05 INFO - 'SHLVL': '1', 03:00:05 INFO - 'TERM': 'linux', 03:00:05 INFO - 'TMOUT': '86400', 03:00:05 INFO - 'USER': 'cltbld', 03:00:05 INFO - 'XDG_SESSION_COOKIE': '3297cc2eebb5444a7688c33f000001b5-1496221020.334826-633799755', 03:00:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:00:05 INFO - '_': '/tools/buildbot/bin/python'} 03:00:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:00:05 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:00:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:00:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:00:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:00:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:00:06 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:00:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:00:06 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:00:06 INFO - Installing collected packages: mozsystemmonitor 03:00:06 INFO - Running setup.py install for mozsystemmonitor 03:00:06 INFO - Successfully installed mozsystemmonitor 03:00:06 INFO - Cleaning up... 03:00:07 INFO - Return code: 0 03:00:07 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:00:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:00:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:00:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:00:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:00:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17283b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1902a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1aa6dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aa3840>, '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 0x1aa4740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1aa4bd0>, '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': '3297cc2eebb5444a7688c33f000001b5-1496221020.334826-633799755', '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 03:00:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 03:00:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 03:00:07 INFO - Using env: {'DISPLAY': ':0', 03:00:07 INFO - 'HOME': '/home/cltbld', 03:00:07 INFO - 'LANG': 'en_US.UTF-8', 03:00:07 INFO - 'LANGUAGE': 'en_US:en', 03:00:07 INFO - 'LOGNAME': 'cltbld', 03:00:07 INFO - 'MAIL': '/var/mail/cltbld', 03:00:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:00:07 INFO - 'MOZ_NO_REMOTE': '1', 03:00:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:00:07 INFO - 'NO_EM_RESTART': '1', 03:00:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:00:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:00:07 INFO - 'PWD': '/builds/slave/test', 03:00:07 INFO - 'SHELL': '/bin/bash', 03:00:07 INFO - 'SHLVL': '1', 03:00:07 INFO - 'TERM': 'linux', 03:00:07 INFO - 'TMOUT': '86400', 03:00:07 INFO - 'USER': 'cltbld', 03:00:07 INFO - 'XDG_SESSION_COOKIE': '3297cc2eebb5444a7688c33f000001b5-1496221020.334826-633799755', 03:00:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:00:07 INFO - '_': '/tools/buildbot/bin/python'} 03:00:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:00:07 INFO - Downloading/unpacking jsonschema==2.5.1 03:00:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:00:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:00:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:00:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:00:08 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:00:08 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:00:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:00:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:00:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:00:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:00:08 INFO - Downloading functools32-3.2.3-2.tar.gz 03:00:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:00:08 INFO - warning: no files found matching '*.txt' 03:00:08 INFO - no previously-included directories found matching 'build' 03:00:08 INFO - no previously-included directories found matching 'dist' 03:00:08 INFO - no previously-included directories found matching '.git*' 03:00:08 INFO - Installing collected packages: jsonschema, functools32 03:00:08 INFO - Running setup.py install for functools32 03:00:08 INFO - warning: no files found matching '*.txt' 03:00:08 INFO - no previously-included directories found matching 'build' 03:00:08 INFO - no previously-included directories found matching 'dist' 03:00:08 INFO - no previously-included directories found matching '.git*' 03:00:08 INFO - Successfully installed jsonschema functools32 03:00:08 INFO - Cleaning up... 03:00:08 INFO - Return code: 0 03:00:08 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:00:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:00:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:00:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:00:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:00:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x17283b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1902a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1aa6dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aa3840>, '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 0x1aa4740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1aa4bd0>, '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': '3297cc2eebb5444a7688c33f000001b5-1496221020.334826-633799755', '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 03:00:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 03:00:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 03:00:08 INFO - Using env: {'DISPLAY': ':0', 03:00:08 INFO - 'HOME': '/home/cltbld', 03:00:08 INFO - 'LANG': 'en_US.UTF-8', 03:00:08 INFO - 'LANGUAGE': 'en_US:en', 03:00:08 INFO - 'LOGNAME': 'cltbld', 03:00:08 INFO - 'MAIL': '/var/mail/cltbld', 03:00:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:00:08 INFO - 'MOZ_NO_REMOTE': '1', 03:00:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:00:08 INFO - 'NO_EM_RESTART': '1', 03:00:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:00:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:00:08 INFO - 'PWD': '/builds/slave/test', 03:00:08 INFO - 'SHELL': '/bin/bash', 03:00:08 INFO - 'SHLVL': '1', 03:00:08 INFO - 'TERM': 'linux', 03:00:08 INFO - 'TMOUT': '86400', 03:00:08 INFO - 'USER': 'cltbld', 03:00:08 INFO - 'XDG_SESSION_COOKIE': '3297cc2eebb5444a7688c33f000001b5-1496221020.334826-633799755', 03:00:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:00:08 INFO - '_': '/tools/buildbot/bin/python'} 03:00:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:00:08 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:00:08 INFO - Cleaning up... 03:00:08 INFO - Return code: 0 03:00:08 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:00:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:00:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:00:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:00:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:00:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x17283b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1902a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1aa6dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aa3840>, '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 0x1aa4740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1aa4bd0>, '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': '3297cc2eebb5444a7688c33f000001b5-1496221020.334826-633799755', '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 03:00:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 03:00:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 03:00:08 INFO - Using env: {'DISPLAY': ':0', 03:00:08 INFO - 'HOME': '/home/cltbld', 03:00:08 INFO - 'LANG': 'en_US.UTF-8', 03:00:08 INFO - 'LANGUAGE': 'en_US:en', 03:00:08 INFO - 'LOGNAME': 'cltbld', 03:00:08 INFO - 'MAIL': '/var/mail/cltbld', 03:00:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:00:08 INFO - 'MOZ_NO_REMOTE': '1', 03:00:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:00:08 INFO - 'NO_EM_RESTART': '1', 03:00:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:00:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:00:08 INFO - 'PWD': '/builds/slave/test', 03:00:08 INFO - 'SHELL': '/bin/bash', 03:00:08 INFO - 'SHLVL': '1', 03:00:08 INFO - 'TERM': 'linux', 03:00:08 INFO - 'TMOUT': '86400', 03:00:08 INFO - 'USER': 'cltbld', 03:00:08 INFO - 'XDG_SESSION_COOKIE': '3297cc2eebb5444a7688c33f000001b5-1496221020.334826-633799755', 03:00:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:00:08 INFO - '_': '/tools/buildbot/bin/python'} 03:00:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:00:09 INFO - Downloading/unpacking blobuploader==1.2.4 03:00:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:00:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:00:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:00:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:00:10 INFO - Downloading blobuploader-1.2.4.tar.gz 03:00:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:00:10 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:00:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:00:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:00:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:00:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:00:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:00:10 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:00:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:00:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:00:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:00:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:00:10 INFO - Downloading docopt-0.6.1.tar.gz 03:00:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:00:10 INFO - Installing collected packages: blobuploader, requests, docopt 03:00:10 INFO - Running setup.py install for blobuploader 03:00:10 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:00:10 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:00:10 INFO - Running setup.py install for requests 03:00:11 INFO - Running setup.py install for docopt 03:00:11 INFO - Successfully installed blobuploader requests docopt 03:00:11 INFO - Cleaning up... 03:00:11 INFO - Return code: 0 03:00:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:00:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:00:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:00:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:00:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:00:11 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 0x17283b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1902a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1aa6dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aa3840>, '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 0x1aa4740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1aa4bd0>, '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': '3297cc2eebb5444a7688c33f000001b5-1496221020.334826-633799755', '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 03:00:11 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 03:00:11 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 03:00:11 INFO - Using env: {'DISPLAY': ':0', 03:00:11 INFO - 'HOME': '/home/cltbld', 03:00:11 INFO - 'LANG': 'en_US.UTF-8', 03:00:11 INFO - 'LANGUAGE': 'en_US:en', 03:00:11 INFO - 'LOGNAME': 'cltbld', 03:00:11 INFO - 'MAIL': '/var/mail/cltbld', 03:00:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:00:11 INFO - 'MOZ_NO_REMOTE': '1', 03:00:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:00:11 INFO - 'NO_EM_RESTART': '1', 03:00:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:00:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:00:11 INFO - 'PWD': '/builds/slave/test', 03:00:11 INFO - 'SHELL': '/bin/bash', 03:00:11 INFO - 'SHLVL': '1', 03:00:11 INFO - 'TERM': 'linux', 03:00:11 INFO - 'TMOUT': '86400', 03:00:11 INFO - 'USER': 'cltbld', 03:00:11 INFO - 'XDG_SESSION_COOKIE': '3297cc2eebb5444a7688c33f000001b5-1496221020.334826-633799755', 03:00:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:00:11 INFO - '_': '/tools/buildbot/bin/python'} 03:00:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:00:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:00:11 INFO - Running setup.py (path:/tmp/pip-ty4mqF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:00:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:00:11 INFO - Running setup.py (path:/tmp/pip-RhaHNi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:00:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:00:11 INFO - Running setup.py (path:/tmp/pip-lorF7Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:00:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:00:11 INFO - Running setup.py (path:/tmp/pip-clwuEo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:00:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:00:11 INFO - Running setup.py (path:/tmp/pip-86KnAX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:00:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:00:11 INFO - Running setup.py (path:/tmp/pip-KTLd30-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:00:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:00:12 INFO - Running setup.py (path:/tmp/pip-PviwuD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:00:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:00:12 INFO - Running setup.py (path:/tmp/pip-D5pPOL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:00:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:00:12 INFO - Running setup.py (path:/tmp/pip-OhsWmC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:00:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:00:12 INFO - Running setup.py (path:/tmp/pip-y5ZU3n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:00:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:00:12 INFO - Running setup.py (path:/tmp/pip-ajZCdm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:00:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:00:12 INFO - Running setup.py (path:/tmp/pip-13Riwi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:00:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:00:12 INFO - Running setup.py (path:/tmp/pip-ZvjXEP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:00:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:00:12 INFO - Running setup.py (path:/tmp/pip-Tg_jfr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:00:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:00:12 INFO - Running setup.py (path:/tmp/pip-1wmoUW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:00:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:00:12 INFO - Running setup.py (path:/tmp/pip-ow4PTX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:00:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:00:12 INFO - Running setup.py (path:/tmp/pip-qn6Km3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:00:12 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:00:12 INFO - Running setup.py install for manifestparser 03:00:12 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:00:12 INFO - Running setup.py install for mozcrash 03:00:13 INFO - Running setup.py install for mozdebug 03:00:13 INFO - Running setup.py install for mozdevice 03:00:13 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:00:13 INFO - Running setup.py install for mozfile 03:00:13 INFO - Running setup.py install for mozhttpd 03:00:13 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:00:13 INFO - Running setup.py install for mozinfo 03:00:13 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:00:13 INFO - Running setup.py install for mozInstall 03:00:13 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:00:13 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:00:13 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:00:13 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:00:13 INFO - Running setup.py install for mozleak 03:00:13 INFO - Running setup.py install for mozlog 03:00:13 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:00:13 INFO - Running setup.py install for moznetwork 03:00:13 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:00:13 INFO - Running setup.py install for mozprocess 03:00:14 INFO - Running setup.py install for mozprofile 03:00:14 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:00:14 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:00:14 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:00:14 INFO - Running setup.py install for mozrunner 03:00:14 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:00:14 INFO - Running setup.py install for mozscreenshot 03:00:14 INFO - Running setup.py install for moztest 03:00:14 INFO - Running setup.py install for mozversion 03:00:14 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:00:14 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:00:14 INFO - Cleaning up... 03:00:14 INFO - Return code: 0 03:00:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:00:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:00:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:00:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:00:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:00:14 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 0x17283b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1902a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1aa6dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aa3840>, '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 0x1aa4740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1aa4bd0>, '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': '3297cc2eebb5444a7688c33f000001b5-1496221020.334826-633799755', '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 03:00:14 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 03:00:14 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 03:00:14 INFO - Using env: {'DISPLAY': ':0', 03:00:14 INFO - 'HOME': '/home/cltbld', 03:00:14 INFO - 'LANG': 'en_US.UTF-8', 03:00:14 INFO - 'LANGUAGE': 'en_US:en', 03:00:14 INFO - 'LOGNAME': 'cltbld', 03:00:14 INFO - 'MAIL': '/var/mail/cltbld', 03:00:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:00:14 INFO - 'MOZ_NO_REMOTE': '1', 03:00:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:00:14 INFO - 'NO_EM_RESTART': '1', 03:00:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:00:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:00:14 INFO - 'PWD': '/builds/slave/test', 03:00:14 INFO - 'SHELL': '/bin/bash', 03:00:14 INFO - 'SHLVL': '1', 03:00:14 INFO - 'TERM': 'linux', 03:00:14 INFO - 'TMOUT': '86400', 03:00:14 INFO - 'USER': 'cltbld', 03:00:14 INFO - 'XDG_SESSION_COOKIE': '3297cc2eebb5444a7688c33f000001b5-1496221020.334826-633799755', 03:00:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:00:14 INFO - '_': '/tools/buildbot/bin/python'} 03:00:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:00:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:00:14 INFO - Running setup.py (path:/tmp/pip-r2sRUt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:00:14 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)) 03:00:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:00:14 INFO - Running setup.py (path:/tmp/pip-zVSwB1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:00:14 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)) 03:00:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:00:14 INFO - Running setup.py (path:/tmp/pip-69zuU4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:00:15 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)) 03:00:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:00:15 INFO - Running setup.py (path:/tmp/pip-Gz5306-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:00:15 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)) 03:00:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:00:15 INFO - Running setup.py (path:/tmp/pip-mmrOvv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:00:15 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)) 03:00:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:00:15 INFO - Running setup.py (path:/tmp/pip-URR7Jd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:00:15 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)) 03:00:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:00:15 INFO - Running setup.py (path:/tmp/pip-910_mE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:00:15 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)) 03:00:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:00:15 INFO - Running setup.py (path:/tmp/pip-sY8sI2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:00:15 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)) 03:00:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:00:15 INFO - Running setup.py (path:/tmp/pip-yA3zfw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:00:15 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)) 03:00:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:00:15 INFO - Running setup.py (path:/tmp/pip-olqOhf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:00:15 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)) 03:00:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:00:15 INFO - Running setup.py (path:/tmp/pip-KBXSQU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:00:15 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)) 03:00:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:00:15 INFO - Running setup.py (path:/tmp/pip-lWrKYw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:00:15 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)) 03:00:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:00:15 INFO - Running setup.py (path:/tmp/pip-fp_172-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:00:15 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)) 03:00:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:00:15 INFO - Running setup.py (path:/tmp/pip-kUElsL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:00:15 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)) 03:00:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:00:15 INFO - Running setup.py (path:/tmp/pip-9hf1FB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:00:15 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)) 03:00:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:00:15 INFO - Running setup.py (path:/tmp/pip-d8Ynup-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:00:16 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)) 03:00:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:00:16 INFO - Running setup.py (path:/tmp/pip-QNePZj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:00:16 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)) 03:00:16 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)) 03:00:16 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)) 03:00:16 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)) 03:00:16 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)) 03:00:16 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)) 03:00:16 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:00:16 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 03:00:16 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 03:00:16 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 03:00:16 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 03:00:17 INFO - Downloading blessings-1.6.tar.gz 03:00:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:00:17 INFO - Installing collected packages: blessings 03:00:17 INFO - Running setup.py install for blessings 03:00:17 INFO - Successfully installed blessings 03:00:17 INFO - Cleaning up... 03:00:17 INFO - Return code: 0 03:00:17 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:00:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:00:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:00:17 INFO - Reading from file tmpfile_stdout 03:00:17 INFO - Current package versions: 03:00:17 INFO - argparse == 1.2.1 03:00:17 INFO - blessings == 1.6 03:00:17 INFO - blobuploader == 1.2.4 03:00:17 INFO - docopt == 0.6.1 03:00:17 INFO - functools32 == 3.2.3-2 03:00:17 INFO - jsonschema == 2.5.1 03:00:17 INFO - manifestparser == 1.1 03:00:17 INFO - mozInstall == 1.12 03:00:17 INFO - mozcrash == 1.0 03:00:17 INFO - mozdebug == 0.1 03:00:17 INFO - mozdevice == 0.51 03:00:17 INFO - mozfile == 1.2 03:00:17 INFO - mozhttpd == 0.7 03:00:17 INFO - mozinfo == 0.9 03:00:17 INFO - mozleak == 0.1 03:00:17 INFO - mozlog == 3.4 03:00:17 INFO - moznetwork == 0.27 03:00:17 INFO - mozprocess == 0.25 03:00:17 INFO - mozprofile == 0.28 03:00:17 INFO - mozrunner == 6.13 03:00:17 INFO - mozscreenshot == 0.1 03:00:17 INFO - mozsystemmonitor == 0.3 03:00:17 INFO - moztest == 0.8 03:00:17 INFO - mozversion == 1.4 03:00:17 INFO - psutil == 3.1.1 03:00:17 INFO - requests == 1.2.3 03:00:17 INFO - wsgiref == 0.1.2 03:00:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:00:17 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')]} 03:00:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:00:17 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')]} 03:00:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:00:17 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 0x17283b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1902a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1aa6dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aa3840>, '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 0x1aa4740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1aa4bd0>, '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': '3297cc2eebb5444a7688c33f000001b5-1496221020.334826-633799755', '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 03:00:17 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 03:00:17 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 03:00:17 INFO - Using env: {'DISPLAY': ':0', 03:00:17 INFO - 'HOME': '/home/cltbld', 03:00:17 INFO - 'LANG': 'en_US.UTF-8', 03:00:17 INFO - 'LANGUAGE': 'en_US:en', 03:00:17 INFO - 'LOGNAME': 'cltbld', 03:00:17 INFO - 'MAIL': '/var/mail/cltbld', 03:00:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:00:17 INFO - 'MOZ_NO_REMOTE': '1', 03:00:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:00:17 INFO - 'NO_EM_RESTART': '1', 03:00:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:00:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:00:17 INFO - 'PWD': '/builds/slave/test', 03:00:17 INFO - 'SHELL': '/bin/bash', 03:00:17 INFO - 'SHLVL': '1', 03:00:17 INFO - 'TERM': 'linux', 03:00:17 INFO - 'TMOUT': '86400', 03:00:17 INFO - 'USER': 'cltbld', 03:00:17 INFO - 'XDG_SESSION_COOKIE': '3297cc2eebb5444a7688c33f000001b5-1496221020.334826-633799755', 03:00:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:00:17 INFO - '_': '/tools/buildbot/bin/python'} 03:00:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:00:17 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)) 03:00:17 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)) 03:00:17 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)) 03:00:17 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)) 03:00:17 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)) 03:00:17 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)) 03:00:17 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)) 03:00:17 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)) 03:00:17 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)) 03:00:17 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 03:00:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:00:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:00:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:00:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:00:18 INFO - Downloading marionette_driver-1.4.0.tar.gz 03:00:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 03:00:19 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)) 03:00:19 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)) 03:00:19 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)) 03:00:19 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)) 03:00:19 INFO - Installing collected packages: marionette-driver 03:00:19 INFO - Running setup.py install for marionette-driver 03:00:19 INFO - Successfully installed marionette-driver 03:00:19 INFO - Cleaning up... 03:00:19 INFO - Return code: 0 03:00:19 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:00:19 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')]} 03:00:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:00:19 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')]} 03:00:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:00:19 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 0x17283b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1902a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1aa6dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aa3840>, '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 0x1aa4740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1aa4bd0>, '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': '3297cc2eebb5444a7688c33f000001b5-1496221020.334826-633799755', '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 03:00:19 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 03:00:19 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 03:00:19 INFO - Using env: {'DISPLAY': ':0', 03:00:19 INFO - 'HOME': '/home/cltbld', 03:00:19 INFO - 'LANG': 'en_US.UTF-8', 03:00:19 INFO - 'LANGUAGE': 'en_US:en', 03:00:19 INFO - 'LOGNAME': 'cltbld', 03:00:19 INFO - 'MAIL': '/var/mail/cltbld', 03:00:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:00:19 INFO - 'MOZ_NO_REMOTE': '1', 03:00:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:00:19 INFO - 'NO_EM_RESTART': '1', 03:00:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:00:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:00:19 INFO - 'PWD': '/builds/slave/test', 03:00:19 INFO - 'SHELL': '/bin/bash', 03:00:19 INFO - 'SHLVL': '1', 03:00:19 INFO - 'TERM': 'linux', 03:00:19 INFO - 'TMOUT': '86400', 03:00:19 INFO - 'USER': 'cltbld', 03:00:19 INFO - 'XDG_SESSION_COOKIE': '3297cc2eebb5444a7688c33f000001b5-1496221020.334826-633799755', 03:00:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:00:19 INFO - '_': '/tools/buildbot/bin/python'} 03:00:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:00:19 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:00:19 INFO - Cleaning up... 03:00:19 INFO - Return code: 0 03:00:19 INFO - Running post-action listener: _resource_record_post_action 03:00:19 INFO - Running post-action listener: _start_resource_monitoring 03:00:19 INFO - Starting resource monitoring. 03:00:19 INFO - [mozharness: 2017-05-31 10:00:19.418748Z] Finished create-virtualenv step (success) 03:00:19 INFO - [mozharness: 2017-05-31 10:00:19.419271Z] Running install step. 03:00:19 INFO - Running pre-action listener: _resource_record_pre_action 03:00:19 INFO - Running main action method: install 03:00:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:00:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:00:19 INFO - Reading from file tmpfile_stdout 03:00:19 INFO - Detecting whether we're running mozinstall >=1.0... 03:00:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:00:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:00:19 INFO - Reading from file tmpfile_stdout 03:00:19 INFO - Output received: 03:00:19 INFO - Usage: mozinstall [options] installer 03:00:19 INFO - Options: 03:00:19 INFO - -h, --help show this help message and exit 03:00:19 INFO - -d DEST, --destination=DEST 03:00:19 INFO - Directory to install application into. [default: 03:00:19 INFO - "/builds/slave/test"] 03:00:19 INFO - --app=APP Application being installed. [default: firefox] 03:00:19 INFO - mkdir: /builds/slave/test/build/application 03:00:19 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'] 03:00:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 03:00:35 INFO - Reading from file tmpfile_stdout 03:00:35 INFO - Output received: 03:00:35 INFO - /builds/slave/test/build/application/firefox/firefox 03:00:35 INFO - Running post-action listener: _resource_record_post_action 03:00:35 INFO - [mozharness: 2017-05-31 10:00:35.989849Z] Finished install step (success) 03:00:35 INFO - [mozharness: 2017-05-31 10:00:35.990125Z] Running setup-mitmproxy step. 03:00:35 INFO - Running pre-action listener: _resource_record_pre_action 03:00:35 INFO - Running main action method: setup_mitmproxy 03:00:35 INFO - Skipping: mitmproxy is not required 03:00:35 INFO - Running post-action listener: _resource_record_post_action 03:00:35 INFO - [mozharness: 2017-05-31 10:00:35.991248Z] Finished setup-mitmproxy step (success) 03:00:35 INFO - [mozharness: 2017-05-31 10:00:35.991467Z] Running run-tests step. 03:00:35 INFO - Running pre-action listener: _resource_record_pre_action 03:00:35 INFO - Running main action method: run_tests 03:00:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:00:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:00:35 INFO - Python 2.7.3 03:00:35 INFO - Return code: 0 03:00:35 INFO - grabbing minidump binary from tooltool 03:00:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:00:35 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 0x1aa3840>, '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 0x1aa4740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1aa4bd0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:00:36 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 03:00:36 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 03:00:36 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 03:00:36 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:00:36 INFO - Return code: 0 03:00:36 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:00:36 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:00:36 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:00:36 INFO - ENV: RUST_BACKTRACE is now 1 03:00:36 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:00:36 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:00:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ZPsXcz3ZRXiFbi_tli0rPA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-083', '--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 03:00:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ZPsXcz3ZRXiFbi_tli0rPA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-083 --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 03:00:36 INFO - Using env: {'DISPLAY': ':0', 03:00:36 INFO - 'HOME': '/home/cltbld', 03:00:36 INFO - 'LANG': 'en_US.UTF-8', 03:00:36 INFO - 'LANGUAGE': 'en_US:en', 03:00:36 INFO - 'LOGNAME': 'cltbld', 03:00:36 INFO - 'MAIL': '/var/mail/cltbld', 03:00:36 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:00:36 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:00:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:00:36 INFO - 'MOZ_NO_REMOTE': '1', 03:00:36 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:00:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:00:36 INFO - 'NO_EM_RESTART': '1', 03:00:36 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:00:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:00:36 INFO - 'PWD': '/builds/slave/test', 03:00:36 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:00:36 INFO - 'RUST_BACKTRACE': '1', 03:00:36 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 03:00:36 INFO - 'SHELL': '/bin/bash', 03:00:36 INFO - 'SHLVL': '1', 03:00:36 INFO - 'TERM': 'linux', 03:00:36 INFO - 'TMOUT': '86400', 03:00:36 INFO - 'USER': 'cltbld', 03:00:36 INFO - 'XDG_SESSION_COOKIE': '3297cc2eebb5444a7688c33f000001b5-1496221020.334826-633799755', 03:00:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:00:36 INFO - '_': '/tools/buildbot/bin/python'} 03:00:36 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ZPsXcz3ZRXiFbi_tli0rPA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-083', '--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 03:00:36 INFO - mozversion application_buildid: 20170531092130 03:00:36 INFO - mozversion application_changeset: 06d83f260f410f125847e95618b6f8b9e83e9a2f 03:00:36 INFO - mozversion application_display_name: Nightly 03:00:36 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:00:36 INFO - mozversion application_name: Firefox 03:00:36 INFO - mozversion application_remotingname: firefox 03:00:36 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 03:00:36 INFO - mozversion application_vendor: Mozilla 03:00:36 INFO - mozversion application_version: 55.0a1 03:00:36 INFO - mozversion platform_buildid: 20170531092130 03:00:36 INFO - mozversion platform_changeset: 06d83f260f410f125847e95618b6f8b9e83e9a2f 03:00:36 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 03:00:36 INFO - mozversion platform_version: 55.0a1 03:00:36 INFO - using testdate: 1496224836 03:00:36 INFO - actual date: 1496224836 03:00:36 INFO - starting webserver on 'localhost:45097' 03:00:36 INFO - SUITE-START | Running 2 tests 03:00:36 INFO - TEST-START | dromaeo_css 03:00:36 INFO - operating with platform_type : linux_ 03:00:36 INFO - Initialising browser for dromaeo_css test... 03:00:36 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:45097/getInfo.html -profile /tmp/tmpjTkkLw/profile 03:00:36 INFO - TEST-INFO | started process 19725 (/builds/slave/test/build/application/firefox/firefox http://localhost:45097/getInfo.html) 03:01:11 INFO - TEST-INFO | 19725: killed by SIGTERM 03:01:11 INFO - Browser initialized. 03:01:11 INFO - Running cycle 1/1 for dromaeo_css test... 03:01:11 INFO - TEST-INFO | started process 19948 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjTkkLw/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:01:23 INFO - PID 19948 | RSS: Main: 187813888 03:01:23 INFO - PID 19948 | 03:04:27 INFO - PID 19948 | Cycle 1(1): loaded http://localhost:45097/tests/dromaeo/cssquery-dojo.html (next: http://localhost:45097/tests/dromaeo/cssquery-ext.html) 03:04:29 INFO - PID 19948 | RSS: Main: 181911552 03:04:29 INFO - PID 19948 | 03:07:31 INFO - PID 19948 | Cycle 1(1): loaded http://localhost:45097/tests/dromaeo/cssquery-ext.html (next: http://localhost:45097/tests/dromaeo/cssquery-jquery.html) 03:07:32 INFO - PID 19948 | RSS: Main: 187449344 03:07:32 INFO - PID 19948 | 03:10:34 INFO - PID 19948 | Cycle 1(1): loaded http://localhost:45097/tests/dromaeo/cssquery-jquery.html (next: http://localhost:45097/tests/dromaeo/cssquery-mootools.html) 03:10:34 INFO - PID 19948 | RSS: Main: 184668160 03:10:34 INFO - PID 19948 | 03:13:36 INFO - PID 19948 | Cycle 1(1): loaded http://localhost:45097/tests/dromaeo/cssquery-mootools.html (next: http://localhost:45097/tests/dromaeo/cssquery-prototype.html) 03:13:37 INFO - PID 19948 | RSS: Main: 190607360 03:13:37 INFO - PID 19948 | 03:16:40 INFO - PID 19948 | Cycle 1(1): loaded http://localhost:45097/tests/dromaeo/cssquery-prototype.html (next: http://localhost:45097/tests/dromaeo/cssquery-yui.html) 03:16:41 INFO - PID 19948 | RSS: Main: 188968960 03:16:41 INFO - PID 19948 | 03:19:42 INFO - PID 19948 | Cycle 1(1): loaded http://localhost:45097/tests/dromaeo/cssquery-yui.html (next: http://localhost:45097/tests/dromaeo/cssquery-dojo.html) 03:19:43 INFO - PID 19948 | RSS: Main: 185360384 03:19:43 INFO - PID 19948 | 03:19:43 INFO - PID 19948 | __start_tp_report 03:19:43 INFO - PID 19948 | _x_x_mozilla_page_load 03:19:43 INFO - PID 19948 | _x_x_mozilla_page_load_details 03:19:43 INFO - PID 19948 | |i|pagename|runs| 03:19:43 INFO - PID 19948 | |0;dojo.html;2725.250556097073;2738.493378724936;2740.9588856167147;2754;2771.1686494051787;5154.768035438405;5315;5322.201669749539;5354.598405119617;5356.491133342336;5225.399079105894;5248.71132087735;5270.683758974465;5332.680039197651;5388.084025715628;4698.365720627706;4727.432708075035;4751.429828420586;4758.857234282959;4797.304390863323;4734.289856521515;4738.620910327183;4804.039192161565;4810.39870016248;4863.489333619972;4595.954040459619;4618.445786505607;4733.455652599961;4764.2615394613895;4815.855524334275;4709.740964246965;4742.478327383985;4771.9522804772205;4779.354787103766;4783;4690.999999999965;4700.976495117503;4707.71753694776;4715.24556071027;4758.476567577563;5105.412877519096;5289.2859463972645;5320.840374788762;5324.068288049614;5345.33183352081;5630.268065151504;5644.491995720405;5748.626339287975;5755.30936287644;5764.279465066867;5793.159991801165;5799.884002319972;5800;5813.534917206655;5848.912266316009;5366.436524164985;5371.785128594852;5379.300690910157;5380.811671591554;5385.461453854583;5760.279965004374;5795.710214489259;5802.767889284466;5836.095405212199;5939.821805345847;5614.831555053355;5616.9157462638095;5634.577406694432;5650.660960342392;5669.036263835158;5735.311762588516;5739.62692424991;5755.3381361143165;5761.308642962871;5772.711364431846;5550.888982220333;5615.578831587565;5740.540756739534;5740.856478587985;5742.16738572913;5611.158326251095;5653.632513886584;5719.142128680731;5735.168400581976;5743.8851222976145;4793.089313030583;4806.615470762331;4824.107540105092;4824.300476430968;4862.41651001882;3999.4800675911947;4107.8973025674;4113.814878330482;4114.259433301974;4143.109231515239;4787.640926930494;4834.154023045953;4852.417709874838;4877.804887804448;4911.312416261726;5762.222100016528;5779.682117483495;5793.449622285876;5795.971020144872;5797.536197104221;4837.250226214942;4873.829415970424;4878.341423907798;4880.048390563877;4909;4941.135301322254;5003.54968052877;5055.317532133115;5115.462876397999;5125.436202017775;5344.278522399426;5349.866253343542;5360.812371566976;5373.220882972026;5415.458454154553;5601.29983752031;5684;5772.134179873053;5782.508486778671;5792.044312688359;5237.554807841376;5269.947300527099;5300.416954135119;5376.247325374373;5401.3248343957;5523.420040895809;5707.9429205709075;5716.056850619601;5717.656940583578;5742.827715168552;5682.602217844711;5701.344345400166;5723.31320241557;5745.1382292656435;5811.389804070681;5571.1086226203615;5578.804741834017;5604.747786349542;5606.467385598362;5647.576431767552;5569.66582005081;5569.693666848362;5570.415106413769;5573.052581061311;5578.665280083208;5350.357957045179;5414.106672399168;5471.972640136773;5488.4237155098135;5566.944330556643;5647.661140331429;5652.434756524314;5656.519195868397;5665.49010589049;5666.405027472056;5409.918851217313;5430.995265875826;5441.347038355423;5458.426865179258;5468.015757163748 03:19:43 INFO - PID 19948 | |1;ext.html;611.1077826373495;672.1900110367006;688.3667026335772;1050.7740835720324;1059.369675043349;30549;31525.211869703213;31526.527102093485;31593.21016974577;31602.525962110587;29769.702302976963;30056.248593785112;30100.698993010064;30118.34349110798;30195.396092078146;6258.718357673915;6389.680515974206;6484.513661475385;6591.670416479157;6652.93347066528;6527.314631963623;6538.8692226155445;6598.241202261754;6613.900791488131;6622.8675426491445;6590.209174899019;6609.570377925444;6633.933660663404;6662.866742665144;6664.500162487809;6555;6607.174103237096;6631.535792494527;6633.900491492632;6640.867182656368;6591.6704164792045;6594.472442204612;6619.073329733841;6634.469242460592;6638.800835974928;29040.41919161626;29127.41745165106;29165.125046248646;29192.708072919213;29271.41457170866;2654.296611397981;2686.355274734069;2687;2687.3953360493733;2694.1648089092446;23023.19418820333;23039.539209215724;23051;23095.53808923829;23115.653265201036;3011.909642710722;3013.6534298555725;3021.6827233140643;3049.710277523654;3069.9539506907413;152627;152655;152881;156225;161197.19401403036;33405.83297083499;33599;33604.32791344159;33605.83197083999;33739.83130084334;34867.476987845206;34881.65118348784;34892.30215395678;34952.12619684528;37303;11495.827562586568;11601.76796464066;11612.94193529027;11618.76762464763;11623.12826538013;9324.440533568008;9357.485338306458;9365.578548965177;9368.250539956787;9385;10889.292196007393;10988.395638239974;11007.229493935347;11166;11213.775724485464;4630.490646028934;4697.242206234999;4725.574698277172;4740.360051393087;4764.928526072112;790.9525428474195;815.6492708135559;824.5382585751878;825.8224481736455;829.6100832608664;19659.60680786405;19738;20213.898930505253;20866.895665521577;21040.368788936357;848.499385362639;859.6819176904586;873.157403105993;899.2895612466209;899.8965119011398;10163.898361016443;10317.587296508056;10909.509072091774;11009.504572294267;11086.390248536247;173305;175008;175523;175537;175950;34919;35138.64861351405;35164.82417587896;35217;35224;1056.529844219315;1079.9136069114452;1084.734240111162;1093.9726506837392;1102.5148934468807;18482.537936551693;23213.651795223424;24858.875705621354;24953.500929981663;25344.746552534238;31466;32146.517802232516;32164.195895101875;32177.230252336347;37166.62833371632;163898;164580;164750;165431;165866;26935.730642694107;27063;27131.1860644181;27205.183844484698;27255.59116613292;30511.847440762653;31375;31537.684623153476;31584.526232106997;31616.683833161373;23833.183598306616;24492.265232043068;24921.376965576004;24994.250172494852;25606.743932560435;24253.393665158514;24785.50428991446;25149.497010060062;25267;26218.08236711706;26819.195424137306;27191;27440.588391173747;27467.31331716723;27876.581851272655;23871.40321491907;24294.392640184138;24577.75422245826;24618.507629846943;25107.121250756136;18845.21572233967;21087.683684745047;21203.46991325229;21263;21678.566428671653 03:19:43 INFO - PID 19948 | |2;jquery.html;361.61307401080836;366.5912507554077;366.96146904575016;372.804277754179;383.2947376826638;16876.15619219039;17465.738013929786;17477.475675729733;17490.912545437288;17522.561935951577;16288.185590720475;16738.079405632685;16957.3217071317;16973.57566060849;16985.235664395103;5487.478689524499;5623.437656234385;5624.268845050137;5634.352049514297;5649.745761440725;5414.269073675043;5449.972750136244;5460.126379779236;5461.481159289861;5467;5376.193570964348;5403.486668766461;5419.214213938976;5427.83716488506;5433.565314774828;5271;5402.054640437927;5413.215083812845;5434.429384914586;5471.616986810925;4927.852164435073;4937.753112344369;4944.925826112575;4957.058158949788;4957.950420495785;21346.252881149085;21713;21750.782492175193;21775.782242177534;21822.23622173232;1640.2372896603017;1655.4371513685285;1661.086402478632;1666.308481979977;1666.8749843761645;14417.062890912162;14782;14854.108753474718;14855.108693478318;14903.478378256817;2009.6282187795305;2121.6817477378363;2125.096833845625;2131.1794958940764;2146.527763891941;104514.47742761314;105989;108252;111449;112166;10294.485275736184;10414.16686665065;10671.679849604525;10672.519736611872;10799.67600971972;14075.859241407456;14153.433862645585;14162.504312349225;14168.291585420688;14174.291285435687;7310.195878453366;7312.524685895506;7333;7530.811729706801;7728.304452599293;6819.659017049128;6829.965850170717;6865.210500792373;6920.792376228721;6936.895946560806;6714.697838597275;6792.456603471809;6797.388235058868;6810.421114205348;6836.145481814773;1800.5138612574794;1801.9909900450414;1807.6746185686702;1809.9457016289268;1991.074150520015;799.132940759271;812.3501199040744;816.7141500474905;819.6311659753135;826.4999675196419;16664.16679166037;16695.833041669426;16698.58253543671;16963.491095266916;17066;812.4312980913385;817.5912043978011;817.7424111404888;819.2708489444399;834.0192043895747;9203.117909026067;9413.246940244764;9708.708738737849;9728.708138755848;9749.951250243845;343272;347685;348519;348750;354015;79741.20258797453;81017.18982810214;83496.16503835005;84169;84989.57505212435;911.284641556375;946.5551190940384;970.3062310447923;975.0931633580838;989.5299732627088;18042.72935905936;18198.181081851082;18534.351297704514;18842.52893677669;18885.527861803566;45455.318170228136;45663;45777.16891324443;45940.54059459363;46566.53433465622;55302.170467442214;56039.439605603424;56208;56919;56949.71525142348;9124.863127052966;9125.22435592982;9189.356745027784;9241.768955776159;9268.629254829732;15583.06501609907;15599.766003510184;15678.764818527503;15679.764803527729;15709.607259818597;13101.606951791462;13126.737465250451;13271.867281327062;13364;13406;11449.942750286194;11950.462229199533;12124.696307701508;12286.692832679255;12896.871031289567;12939.805902911276;13557.186568805902;13722.931385343409;13818.170909745448;13826.861731382558;9310.581023854078;9374.531273436438;9379.718608441757;9431.434113953184;9442.339036267394;12104.490055182845;12181.939090304491;12226.755464890475;12251.142420030512;12252.632421027383 03:19:43 INFO - PID 19948 | |3;mootools.html;1076.8330908709147;1104.5140138339125;1125.8367536707171;1126.892945170209;1141.9885801141986;9847.409155450678;10148.949255253732;10329.431881246528;10340.896591034098;10465.05814476697;10016.198704103672;10122.898771012287;10147.137493313077;10227.948860255707;10242.77086749591;2115.9894200529016;2148.495103650641;2158.6330323844904;2167.2631305356176;2168.327818376308;2142.3465842917904;2172.934811955644;2173.5326904715484;2178.3900507857825;2179.182806447582;2108.188347486221;2127.7765834587376;2136.519283161284;2143.185589475997;2147.0552956699003;2071.4510654676524;2077.3248694174376;2079.6690118324286;2086.739157605299;2090.6341390256644;1787.5977904971407;1855.8422534084618;2048.047657839097;2055.219016773631;2160.79472450117;10318.638847640372;10391.948040259826;10458.215633827418;10464.52909619069;10508.842367364496;5231.5291623753665;5456.972715136439;5458.044842152607;5460.481254280837;5460.645058071213;3071.6467606225124;3196.1530194498478;3254.170186602425;3255.6744325567493;3256.625488068879;989.5893204320198;999.6651121874108;1007.5566750629773;1017.1201910347496;1022.504085518523;15245.695086098327;15267.770983435257;15270.694586108326;15411.075335479907;15468.613284667861;4447.266201076786;4452.220861349251;4472.530384309601;4592.494825569184;4594.759414958009;10798.51406686701;10833.404162770965;10850.131989440826;10892.782144357068;10915.39965301916;4887.682300650446;4958.776855041532;4983.6013118950395;5004.2493625956395;5004.649674522821;4589.173948689201;4611.930821037688;4632.536746325341;4647.256438969816;4649.814007439732;3617.620149884277;3634.109643137448;3699.260147970363;3745.4007358823;3765.3034188675183;990.1039559198792;1007.8790545134631;1022.483645758887;1025.6512785652765;1029.2177944761886;627.5159248377554;645.954325355949;656.136808978085;661.0879077662903;661.6129564204898;5746.741396637078;5833.88332233353;5842.065269556935;5861.941380586225;6074.42292982166;757.6817736550662;774.8489044636354;778.7858338956719;791.6081539637917;806.5120602035802;3668.1746607013743;3672.4674922136674;3688.5389326334207;3739.4390841373465;3757.1170774867883;13239.139455935334;13392.799108013387;14063;14073.437062517385;14077.577672669837;13823.79264311016;14004.509842155476;14158.29208539569;14173.929130354281;14187.219702916438;7193.64031798408;7539.585322807298;7603.543787372775;7610.1628820829665;7644.006279183671;5894.528437724886;5934.169216309634;5955.583109182316;6008.309044459943;6237.500999919905;12114.394280285775;12288.938555307166;12432.191907525981;12439.191452555555;12487.812682809583;12519.561815336783;12533.185342952678;12569.685757855761;12698.809517857424;12774.936125319315;8255.793605159919;8315.201117876084;8334.791630209293;8402.915970840213;8412.62143203545;9625.32622716403;9642.228621710387;9681.128698417177;9686.951565242129;9722.125008749246;8128.471649342774;8199.754007379788;8208.876866847122;8275.089740128702;8358.247757701836;7729.420293478124;7758.883616745867;7779.688812447665;7869.763907082796;7887.9605601971625;7241.746538871325;7254.927450725636;7294.1247050354295;7316.561006339423;7364;4545.227311357144;5255.343082114736;5335.359756829205;5365.061114305059;5416.808302173516;5165.276861239355;5231.29377534028;5232.450592687713;5284.203370853928;5297.841064768063 03:19:43 INFO - PID 19948 | |4;prototype.html;338.50578155892396;346.44568690095866;350.5688003755382;359.2653024564765;364.2805459218044;5617.21359009739;5650.898074875401;5656.264685590872;5699.68651724155;5701.885962280757;5491.313585801775;5505.421930697269;5537.750801213945;5539.501444869961;5569.220309156722;3996.920061598766;4126.360414135814;4126.896827579305;4129.174165166979;4130.752154870703;4110.342345224764;4126.628603425691;4141.6065473779945;4144.295469770132;4144.41978123063;4077.938830917539;4080.469538959931;4081.795910204493;4086.162336720965;4101.446304748865;4080.245154646385;4082.1835632873544;4104.117614712821;4106.29588720682;4106.815193316308;3578.7315951303494;3581.176329444216;3581.8567257309937;3590.8204589770667;3597.5143355647174;5401.78392864285;5403.621746477748;5411.080116380225;5418.620696551243;5457.208704737791;4883.536064073943;4887.780049897728;4890.535399137077;4910.312556242129;4913.385826771653;5848.982101175087;5857.912131318034;5874.706264686749;5878.882422351529;5882.882342353129;4034.495688038995;4036.777977211252;4037.4953130858644;4039.798010099513;4040.313146765028;5801.30384353876;6206.441420272197;6252;6276.184096067527;6305.369463053704;4033.9394909076386;4048.554658987509;4050.8177132029127;4061.289274376972;4100.938485922714;4119.237940980928;4135.255653982312;4138.730982486129;4139.048018955657;4139.275626765304;4716.952830471651;4814.711117332971;4820.4456487503685;4833.854984350475;4836.854894353175;5837.9124313135335;5851.853703657443;5865.677387743715;5884.705764711747;5894.233749612608;1421.7938398932304;1453.5203382883624;1453.9200343981183;1454.280131334996;1459.058907004997;912.0104686415314;946.9914541013799;950.1828427552299;951.2295041016798;951.785848184153;5027.84916452507;5068.873278168076;5083.186690129635;5090.0583392072585;5103.87240318995;6068.605540639845;6079.179310792986;6092.557704896808;6119.326874043852;6139.877202456015;5046.39443266803;5067.138586440314;5075.360812377543;5082.364704411949;5101.668391554611;3220.533022711694;3223.6615155408813;3249.6425393206728;3250.9837450813066;3256.1859535116223;5626.803061892896;5638;5656.462636049569;5658.490735833712;5671.2060311556415;6245.96877015612;6249.312575616678;6256.937430625727;6275;6287.9056814147825;5629.324481062299;5647.322321321386;5666.886662266732;5674.347450043216;5694.117411801178;6088.4215999479975;6092.268927728701;6105.45050945417;6124.724387402489;6151.169592105009;5989.880202396015;6002.969985150046;6003.759849606142;6013.488853447506;6033.456988871023;5283.339582552181;5432.728363581884;5525.171224316385;5640.407757185437;5652.830415087554;4011.318075927041;4062.6546743527133;4079.449274347925;4091.2635725569685;4101.077257617012;6094.2077529920825;6097.664628445478;6119;6123.142760013513;6141.631502109888;5723.599348045597;5868.295804503487;5888.352281249145;5898.616589921641;5900.023492130184;5855.560832937462;5859.472647461749;5890.617109887844;5894.970525147347;5909.497692696169;5833.329167145833;5851.824445266649;5855.970720146372;5864.736086876186;5889;5964.194833697396;5964.552658550713;5970.97014514942;5989.550783691154;6014.188084608521;5756.798512052058;5764.164196191445;5785.30576330843;5801.158831969426;5811.128330750421 03:19:43 INFO - PID 19948 | |5;yui.html;629.981100566983;638.4828289085841;642.7718160053181;643.4498503779272;647.8412788866729;12936.353182340881;13295.800562991562;13367.532136375228;15449.150296733675;16833.15834208288;14787.186704731263;14972.251387430611;14989.100653960742;14989.400423983056;14991.175485348302;641.5380925733476;646.1535388640872;647.8380404898776;648.3775575447553;650.681166228547;647.6826355085998;651.4723074309801;658.9439897608709;671.493022767812;747.5552046532305;685.8868286732683;693.3205458650525;693.3413257405459;693.9763848323732;694.0248950224917;680.3026897430125;684.9931500685029;687.2714922182503;687.9140107486564;690.2097098821846;497.46025562264987;504.684572142411;512.8076971135824;513.6147889083188;529.9576033917277;13486.39311230997;13765.793513097311;13809;13828.585142445743;13861.930690346584;14169.645758856112;15146;15371.769423458545;15453.304601292968;15457.536273911688;12225.327606981613;12514.374281285991;12663.796939290753;12675.492980280778;12806;2958.4378967996013;2980.2549362659333;2980.5678176664264;2986.462436761382;2986.5221564549784;86592.56703716441;87550.562247189;88070.55964720136;88374.11625883722;89356.5532172335;11890.881091188978;11994.220375675728;12168.69578260533;12188.20776649515;12230.205036672587;20092.296769612993;20286;20844.478888027617;20849.166033358495;20900;6285.214348206474;6305.873882522415;6327.114204011442;6359.841003974938;6371.776987805404;2869.727375899286;2869.9856500717365;2915.8833646653898;2945.4109178164026;2978.3149875528316;3343;3406;3417.4019546579248;3432.845521951518;3445.586529616462;718.90294810201;736.4513437488998;738.4092725819323;739.6227923758814;739.8113481062402;545.6235197713565;571.4799532425473;571.6655756382563;572.8596493858948;576.3746335226242;9933.801323973625;10331.793364132674;10603;10681.11609865332;11432;561.4525837308673;571.6398668838605;571.8484601580584;575.2694078520256;588.6879953624585;4128.649064829463;4218.7679677618025;4292.978535107367;4338.154059958341;4680.251159814481;76697.61651191708;77419;77940.22059779329;78568.607156965;80164.59917700491;64025.35974640287;64830.67584662046;65731.67134164298;65872.34127658662;69851.65074174597;58578.414215857294;59349.406505934385;59859.700701496215;60807;61767;9222.262219022328;9261.351705380828;9405.529723513933;9447.433154010781;10300.381977081399;32050.519242210918;32084.35831283408;32567.674323256466;33275.16812079717;33734;57173.428265718474;57749.422505774404;57861;60427.395726042174;61055.694721527885;13435.462581497022;13778.862211377758;13968.092074015156;14004.36980335867;14149.08030977983;16049;16295.837041629906;16476.505704828873;16637.168141593113;16699.91650041742;14557.272136392927;14726;14929.477468288558;15063.397464101752;15184.696306073596;14222.502212422516;14523.419063237352;14596.12423254608;14626.488072917396;14728.337224824694;13407.396667149807;14270.71458570802;14346.856531434552;14409.495667651581;14749.631259218177;10366;10411.745772363702;10881.945590271998;11112.22214444981;11143.83284250753;11075.889241107487;11536.134789890624;11656.125790565571;11858;11863.703407414883 03:19:43 INFO - PID 19948 | __end_tp_report 03:19:43 INFO - PID 19948 | __start_cc_report 03:19:43 INFO - PID 19948 | _x_x_mozilla_cycle_collect,398 03:19:43 INFO - PID 19948 | __end_cc_report 03:19:43 INFO - PID 19948 | __startTimestamp1496225983221__endTimestamp 03:19:43 INFO - PID 19948 | 03:19:43 INFO - PID 19948 | ------- Summary: start ------- 03:19:43 INFO - PID 19948 | Number of tests: 6 03:19:43 INFO - PID 19948 | 03:19:43 INFO - PID 19948 | [#0] dojo.html Cycles:165 Average:5237.99 Median:5385.46 stddev:619.26 (11.5%) stddev-sans-first:588.96 03:19:43 INFO - PID 19948 | Values: 2725.3 2738.5 2741.0 2754.0 2771.2 5154.8 5315.0 5322.2 5354.6 5356.5 5225.4 5248.7 5270.7 5332.7 5388.1 4698.4 4727.4 4751.4 4758.9 4797.3 4734.3 4738.6 4804.0 4810.4 4863.5 4596.0 4618.4 4733.5 4764.3 4815.9 4709.7 4742.5 4772.0 4779.4 4783.0 4691.0 4701.0 4707.7 4715.2 4758.5 5105.4 5289.3 5320.8 5324.1 5345.3 5630.3 5644.5 5748.6 5755.3 5764.3 5793.2 5799.9 5800.0 5813.5 5848.9 5366.4 5371.8 5379.3 5380.8 5385.5 5760.3 5795.7 5802.8 5836.1 5939.8 5614.8 5616.9 5634.6 5650.7 5669.0 5735.3 5739.6 5755.3 5761.3 5772.7 5550.9 5615.6 5740.5 5740.9 5742.2 5611.2 5653.6 5719.1 5735.2 5743.9 4793.1 4806.6 4824.1 4824.3 4862.4 3999.5 4107.9 4113.8 4114.3 4143.1 4787.6 4834.2 4852.4 4877.8 4911.3 5762.2 5779.7 5793.4 5796.0 5797.5 4837.3 4873.8 4878.3 4880.0 4909.0 4941.1 5003.5 5055.3 5115.5 5125.4 5344.3 5349.9 5360.8 5373.2 5415.5 5601.3 5684.0 5772.1 5782.5 5792.0 5237.6 5269.9 5300.4 5376.2 5401.3 5523.4 5707.9 5716.1 5717.7 5742.8 5682.6 5701.3 5723.3 5745.1 5811.4 5571.1 5578.8 5604.7 5606.5 5647.6 5569.7 5569.7 5570.4 5573.1 5578.7 5350.4 5414.1 5472.0 5488.4 5566.9 5647.7 5652.4 5656.5 5665.5 5666.4 5409.9 5431.0 5441.3 5458.4 5468.0 03:19:43 INFO - PID 19948 | 03:19:43 INFO - PID 19948 | [#1] ext.html Cycles:180 Average:29449.29 Median:29232.06 stddev:42643.51 (145.9%) stddev-sans-first:42708.16 03:19:43 INFO - PID 19948 | Values: 611.1 672.2 688.4 1050.8 1059.4 30549.0 31525.2 31526.5 31593.2 31602.5 29769.7 30056.2 30100.7 30118.3 30195.4 6258.7 6389.7 6484.5 6591.7 6652.9 6527.3 6538.9 6598.2 6613.9 6622.9 6590.2 6609.6 6633.9 6662.9 6664.5 6555.0 6607.2 6631.5 6633.9 6640.9 6591.7 6594.5 6619.1 6634.5 6638.8 29040.4 29127.4 29165.1 29192.7 29271.4 2654.3 2686.4 2687.0 2687.4 2694.2 23023.2 23039.5 23051.0 23095.5 23115.7 3011.9 3013.7 3021.7 3049.7 3070.0 152627.0 152655.0 152881.0 156225.0 161197.2 33405.8 33599.0 33604.3 33605.8 33739.8 34867.5 34881.7 34892.3 34952.1 37303.0 11495.8 11601.8 11612.9 11618.8 11623.1 9324.4 9357.5 9365.6 9368.3 9385.0 10889.3 10988.4 11007.2 11166.0 11213.8 4630.5 4697.2 4725.6 4740.4 4764.9 791.0 815.6 824.5 825.8 829.6 19659.6 19738.0 20213.9 20866.9 21040.4 848.5 859.7 873.2 899.3 899.9 10163.9 10317.6 10909.5 11009.5 11086.4 173305.0 175008.0 175523.0 175537.0 175950.0 34919.0 35138.6 35164.8 35217.0 35224.0 1056.5 1079.9 1084.7 1094.0 1102.5 18482.5 23213.7 24858.9 24953.5 25344.7 31466.0 32146.5 32164.2 32177.2 37166.6 163898.0 164580.0 164750.0 165431.0 165866.0 26935.7 27063.0 27131.2 27205.2 27255.6 30511.8 31375.0 31537.7 31584.5 31616.7 23833.2 24492.3 24921.4 24994.3 25606.7 24253.4 24785.5 25149.5 25267.0 26218.1 26819.2 27191.0 27440.6 27467.3 27876.6 23871.4 24294.4 24577.8 24618.5 25107.1 18845.2 21087.7 21203.5 21263.0 21678.6 03:19:43 INFO - PID 19948 | 03:19:43 INFO - PID 19948 | [#2] jquery.html Cycles:180 Average:25662.59 Median:364.10 stddev:59158.15 (16247.7%) stddev-sans-first:59293.60 03:19:43 INFO - PID 19948 | Values: 361.6 366.6 367.0 372.8 383.3 16876.2 17465.7 17477.5 17490.9 17522.6 16288.2 16738.1 16957.3 16973.6 16985.2 5487.5 5623.4 5624.3 5634.4 5649.7 5414.3 5450.0 5460.1 5461.5 5467.0 5376.2 5403.5 5419.2 5427.8 5433.6 5271.0 5402.1 5413.2 5434.4 5471.6 4927.9 4937.8 4944.9 4957.1 4958.0 21346.3 21713.0 21750.8 21775.8 21822.2 1640.2 1655.4 1661.1 1666.3 1666.9 14417.1 14782.0 14854.1 14855.1 14903.5 2009.6 2121.7 2125.1 2131.2 2146.5 104514.5 105989.0 108252.0 111449.0 112166.0 10294.5 10414.2 10671.7 10672.5 10799.7 14075.9 14153.4 14162.5 14168.3 14174.3 7310.2 7312.5 7333.0 7530.8 7728.3 6819.7 6830.0 6865.2 6920.8 6936.9 6714.7 6792.5 6797.4 6810.4 6836.1 1800.5 1802.0 1807.7 1809.9 1991.1 799.1 812.4 816.7 819.6 826.5 16664.2 16695.8 16698.6 16963.5 17066.0 812.4 817.6 817.7 819.3 834.0 9203.1 9413.2 9708.7 9728.7 9750.0 343272.0 347685.0 348519.0 348750.0 354015.0 79741.2 81017.2 83496.2 84169.0 84989.6 911.3 946.6 970.3 975.1 989.5 18042.7 18198.2 18534.4 18842.5 18885.5 45455.3 45663.0 45777.2 45940.5 46566.5 55302.2 56039.4 56208.0 56919.0 56949.7 9124.9 9125.2 9189.4 9241.8 9268.6 15583.1 15599.8 15678.8 15679.8 15709.6 13101.6 13126.7 13271.9 13364.0 13406.0 11449.9 11950.5 12124.7 12286.7 12896.9 12939.8 13557.2 13722.9 13818.2 13826.9 9310.6 9374.5 9379.7 9431.4 9442.3 12104.5 12181.9 12226.8 12251.1 12252.6 03:19:43 INFO - PID 19948 | 03:19:43 INFO - PID 19948 | [#3] mootools.html Cycles:180 Average:6283.01 Median:3693.90 stddev:4209.75 (114.0%) stddev-sans-first:4203.38 03:19:43 INFO - PID 19948 | Values: 1076.8 1104.5 1125.8 1126.9 1142.0 9847.4 10148.9 10329.4 10340.9 10465.1 10016.2 10122.9 10147.1 10227.9 10242.8 2116.0 2148.5 2158.6 2167.3 2168.3 2142.3 2172.9 2173.5 2178.4 2179.2 2108.2 2127.8 2136.5 2143.2 2147.1 2071.5 2077.3 2079.7 2086.7 2090.6 1787.6 1855.8 2048.0 2055.2 2160.8 10318.6 10391.9 10458.2 10464.5 10508.8 5231.5 5457.0 5458.0 5460.5 5460.6 3071.6 3196.2 3254.2 3255.7 3256.6 989.6 999.7 1007.6 1017.1 1022.5 15245.7 15267.8 15270.7 15411.1 15468.6 4447.3 4452.2 4472.5 4592.5 4594.8 10798.5 10833.4 10850.1 10892.8 10915.4 4887.7 4958.8 4983.6 5004.2 5004.6 4589.2 4611.9 4632.5 4647.3 4649.8 3617.6 3634.1 3699.3 3745.4 3765.3 990.1 1007.9 1022.5 1025.7 1029.2 627.5 646.0 656.1 661.1 661.6 5746.7 5833.9 5842.1 5861.9 6074.4 757.7 774.8 778.8 791.6 806.5 3668.2 3672.5 3688.5 3739.4 3757.1 13239.1 13392.8 14063.0 14073.4 14077.6 13823.8 14004.5 14158.3 14173.9 14187.2 7193.6 7539.6 7603.5 7610.2 7644.0 5894.5 5934.2 5955.6 6008.3 6237.5 12114.4 12288.9 12432.2 12439.2 12487.8 12519.6 12533.2 12569.7 12698.8 12774.9 8255.8 8315.2 8334.8 8402.9 8412.6 9625.3 9642.2 9681.1 9687.0 9722.1 8128.5 8199.8 8208.9 8275.1 8358.2 7729.4 7758.9 7779.7 7869.8 7888.0 7241.7 7254.9 7294.1 7316.6 7364.0 4545.2 5255.3 5335.4 5365.1 5416.8 5165.3 5231.3 5232.5 5284.2 5297.8 03:19:43 INFO - PID 19948 | 03:19:43 INFO - PID 19948 | [#4] prototype.html Cycles:180 Average:4817.59 Median:5538.63 stddev:1460.53 (26.4%) stddev-sans-first:1425.41 03:19:43 INFO - PID 19948 | Values: 338.5 346.4 350.6 359.3 364.3 5617.2 5650.9 5656.3 5699.7 5701.9 5491.3 5505.4 5537.8 5539.5 5569.2 3996.9 4126.4 4126.9 4129.2 4130.8 4110.3 4126.6 4141.6 4144.3 4144.4 4077.9 4080.5 4081.8 4086.2 4101.4 4080.2 4082.2 4104.1 4106.3 4106.8 3578.7 3581.2 3581.9 3590.8 3597.5 5401.8 5403.6 5411.1 5418.6 5457.2 4883.5 4887.8 4890.5 4910.3 4913.4 5849.0 5857.9 5874.7 5878.9 5882.9 4034.5 4036.8 4037.5 4039.8 4040.3 5801.3 6206.4 6252.0 6276.2 6305.4 4033.9 4048.6 4050.8 4061.3 4100.9 4119.2 4135.3 4138.7 4139.0 4139.3 4717.0 4814.7 4820.4 4833.9 4836.9 5837.9 5851.9 5865.7 5884.7 5894.2 1421.8 1453.5 1453.9 1454.3 1459.1 912.0 947.0 950.2 951.2 951.8 5027.8 5068.9 5083.2 5090.1 5103.9 6068.6 6079.2 6092.6 6119.3 6139.9 5046.4 5067.1 5075.4 5082.4 5101.7 3220.5 3223.7 3249.6 3251.0 3256.2 5626.8 5638.0 5656.5 5658.5 5671.2 6246.0 6249.3 6256.9 6275.0 6287.9 5629.3 5647.3 5666.9 5674.3 5694.1 6088.4 6092.3 6105.5 6124.7 6151.2 5989.9 6003.0 6003.8 6013.5 6033.5 5283.3 5432.7 5525.2 5640.4 5652.8 4011.3 4062.7 4079.4 4091.3 4101.1 6094.2 6097.7 6119.0 6123.1 6141.6 5723.6 5868.3 5888.4 5898.6 5900.0 5855.6 5859.5 5890.6 5895.0 5909.5 5833.3 5851.8 5856.0 5864.7 5889.0 5964.2 5964.6 5971.0 5989.6 6014.2 5756.8 5764.2 5785.3 5801.2 5811.1 03:19:43 INFO - PID 19948 | 03:19:43 INFO - PID 19948 | [#5] yui.html Cycles:180 Average:17486.14 Median:18570.00 stddev:22785.04 (122.7%) stddev-sans-first:22813.80 03:19:43 INFO - PID 19948 | Values: 630.0 638.5 642.8 643.4 647.8 12936.4 13295.8 13367.5 15449.2 16833.2 14787.2 14972.3 14989.1 14989.4 14991.2 641.5 646.2 647.8 648.4 650.7 647.7 651.5 658.9 671.5 747.6 685.9 693.3 693.3 694.0 694.0 680.3 685.0 687.3 687.9 690.2 497.5 504.7 512.8 513.6 530.0 13486.4 13765.8 13809.0 13828.6 13861.9 14169.6 15146.0 15371.8 15453.3 15457.5 12225.3 12514.4 12663.8 12675.5 12806.0 2958.4 2980.3 2980.6 2986.5 2986.5 86592.6 87550.6 88070.6 88374.1 89356.6 11890.9 11994.2 12168.7 12188.2 12230.2 20092.3 20286.0 20844.5 20849.2 20900.0 6285.2 6305.9 6327.1 6359.8 6371.8 2869.7 2870.0 2915.9 2945.4 2978.3 3343.0 3406.0 3417.4 3432.8 3445.6 718.9 736.5 738.4 739.6 739.8 545.6 571.5 571.7 572.9 576.4 9933.8 10331.8 10603.0 10681.1 11432.0 561.5 571.6 571.8 575.3 588.7 4128.6 4218.8 4293.0 4338.2 4680.3 76697.6 77419.0 77940.2 78568.6 80164.6 64025.4 64830.7 65731.7 65872.3 69851.7 58578.4 59349.4 59859.7 60807.0 61767.0 9222.3 9261.4 9405.5 9447.4 10300.4 32050.5 32084.4 32567.7 33275.2 33734.0 57173.4 57749.4 57861.0 60427.4 61055.7 13435.5 13778.9 13968.1 14004.4 14149.1 16049.0 16295.8 16476.5 16637.2 16699.9 14557.3 14726.0 14929.5 15063.4 15184.7 14222.5 14523.4 14596.1 14626.5 14728.3 13407.4 14270.7 14346.9 14409.5 14749.6 10366.0 10411.7 10881.9 11112.2 11143.8 11075.9 11536.1 11656.1 11858.0 11863.7 03:19:43 INFO - PID 19948 | -------- Summary: end -------- 03:19:43 INFO - PID 19948 | 03:19:44 INFO - TEST-INFO | 19948: exit 0 03:19:44 INFO - TEST-OK | dromaeo_css | took 1147850ms 03:19:44 INFO - TEST-START | kraken 03:19:44 INFO - operating with platform_type : linux_ 03:19:44 INFO - Initialising browser for kraken test... 03:19:44 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:45097/getInfo.html -profile /tmp/tmpjVNyGo/profile 03:19:44 INFO - TEST-INFO | started process 20369 (/builds/slave/test/build/application/firefox/firefox http://localhost:45097/getInfo.html) 03:20:19 INFO - TEST-INFO | 20369: killed by SIGTERM 03:20:19 INFO - Browser initialized. 03:20:19 INFO - Running cycle 1/1 for kraken test... 03:20:19 INFO - TEST-INFO | started process 20594 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjVNyGo/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:20:31 INFO - PID 20594 | RSS: Main: 188043264 03:20:31 INFO - PID 20594 | 03:20:33 INFO - PID 20594 | Cycle 1(1): loaded http://localhost:45097/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:45097/tests/kraken/driver.html?testName=audio-beat-detection) 03:20:34 INFO - PID 20594 | RSS: Main: 191918080 03:20:34 INFO - PID 20594 | 03:20:37 INFO - PID 20594 | Cycle 1(1): loaded http://localhost:45097/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:45097/tests/kraken/driver.html?testName=audio-dft) 03:20:38 INFO - PID 20594 | RSS: Main: 190615552 03:20:38 INFO - PID 20594 | 03:20:41 INFO - PID 20594 | Cycle 1(1): loaded http://localhost:45097/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:45097/tests/kraken/driver.html?testName=audio-fft) 03:20:41 INFO - PID 20594 | RSS: Main: 185942016 03:20:41 INFO - PID 20594 | 03:20:43 INFO - PID 20594 | Cycle 1(1): loaded http://localhost:45097/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:45097/tests/kraken/driver.html?testName=audio-oscillator) 03:20:44 INFO - PID 20594 | RSS: Main: 186593280 03:20:44 INFO - PID 20594 | 03:20:46 INFO - PID 20594 | Cycle 1(1): loaded http://localhost:45097/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:45097/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:20:47 INFO - PID 20594 | RSS: Main: 186785792 03:20:47 INFO - PID 20594 | 03:20:50 INFO - PID 20594 | Cycle 1(1): loaded http://localhost:45097/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:45097/tests/kraken/driver.html?testName=imaging-darkroom) 03:20:50 INFO - PID 20594 | RSS: Main: 187781120 03:20:50 INFO - PID 20594 | 03:20:54 INFO - PID 20594 | Cycle 1(1): loaded http://localhost:45097/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:45097/tests/kraken/driver.html?testName=imaging-desaturate) 03:20:55 INFO - PID 20594 | RSS: Main: 186667008 03:20:55 INFO - PID 20594 | 03:20:58 INFO - PID 20594 | Cycle 1(1): loaded http://localhost:45097/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:45097/tests/kraken/driver.html?testName=json-parse-financial) 03:20:58 INFO - PID 20594 | RSS: Main: 187400192 03:20:58 INFO - PID 20594 | 03:21:00 INFO - PID 20594 | Cycle 1(1): loaded http://localhost:45097/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:45097/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:21:00 INFO - PID 20594 | RSS: Main: 188055552 03:21:00 INFO - PID 20594 | 03:21:02 INFO - PID 20594 | Cycle 1(1): loaded http://localhost:45097/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:45097/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:21:03 INFO - PID 20594 | RSS: Main: 187224064 03:21:03 INFO - PID 20594 | 03:21:05 INFO - PID 20594 | Cycle 1(1): loaded http://localhost:45097/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:45097/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:21:06 INFO - PID 20594 | RSS: Main: 187322368 03:21:06 INFO - PID 20594 | 03:21:09 INFO - PID 20594 | Cycle 1(1): loaded http://localhost:45097/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:45097/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:21:09 INFO - PID 20594 | RSS: Main: 187703296 03:21:09 INFO - PID 20594 | 03:21:13 INFO - PID 20594 | Cycle 1(1): loaded http://localhost:45097/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:45097/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:21:13 INFO - PID 20594 | RSS: Main: 187281408 03:21:13 INFO - PID 20594 | 03:21:15 INFO - PID 20594 | Cycle 1(1): loaded http://localhost:45097/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:45097/tests/kraken/driver.html?testName=ai-astar) 03:21:15 INFO - PID 20594 | RSS: Main: 188551168 03:21:15 INFO - PID 20594 | 03:21:15 INFO - PID 20594 | __start_tp_report 03:21:15 INFO - PID 20594 | _x_x_mozilla_page_load 03:21:15 INFO - PID 20594 | _x_x_mozilla_page_load_details 03:21:15 INFO - PID 20594 | |i|pagename|runs| 03:21:15 INFO - PID 20594 | |0;ai-astar;103;111;110;109;110;109;111;112;114;113 03:21:15 INFO - PID 20594 | |1;audio-beat-detection;147;123;123;174;125;123;125;125;149;128 03:21:15 INFO - PID 20594 | |2;audio-dft;164;164;164;169;166;173;172;167;162;163 03:21:15 INFO - PID 20594 | |3;audio-fft;74;74;74;110;76;76;74;75;95;75 03:21:15 INFO - PID 20594 | |4;audio-oscillator;84;82;113;83;83;82;99;83;82;105 03:21:15 INFO - PID 20594 | |5;imaging-gaussian-blur;114;114;114;114;116;118;116;115;114;115 03:21:15 INFO - PID 20594 | |6;imaging-darkroom;152;151;152;150;151;151;152;151;152;151 03:21:15 INFO - PID 20594 | |7;imaging-desaturate;95;95;95;94;94;96;94;96;94;95 03:21:15 INFO - PID 20594 | |8;json-parse-financial;54;55;58;55;56;57;56;56;57;56 03:21:15 INFO - PID 20594 | |9;json-stringify-tinderbox;56;57;56;56;57;56;56;56;58;60 03:21:15 INFO - PID 20594 | |10;stanford-crypto-aes;87;87;86;87;86;87;89;87;125;87 03:21:15 INFO - PID 20594 | |11;stanford-crypto-ccm;135;134;131;137;138;135;132;134;131;135 03:21:15 INFO - PID 20594 | |12;stanford-crypto-pbkdf2;184;193;202;195;195;194;193;185;193;196 03:21:15 INFO - PID 20594 | |13;stanford-crypto-sha256-iterative;74;73;71;75;72;76;72;77;74;77 03:21:15 INFO - PID 20594 | __end_tp_report 03:21:15 INFO - PID 20594 | __start_cc_report 03:21:15 INFO - PID 20594 | _x_x_mozilla_cycle_collect,1058 03:21:15 INFO - PID 20594 | __end_cc_report 03:21:15 INFO - PID 20594 | __startTimestamp1496226075695__endTimestamp 03:21:15 INFO - PID 20594 | 03:21:15 INFO - PID 20594 | ------- Summary: start ------- 03:21:15 INFO - PID 20594 | Number of tests: 14 03:21:15 INFO - PID 20594 | 03:21:15 INFO - PID 20594 | [#0] ai-astar Cycles:10 Average:110.20 Median:111.00 stddev:3.01 (2.7%) stddev-sans-first:1.73 03:21:15 INFO - PID 20594 | Values: 103.0 111.0 110.0 109.0 110.0 109.0 111.0 112.0 114.0 113.0 03:21:15 INFO - PID 20594 | 03:21:15 INFO - PID 20594 | [#1] audio-beat-detection Cycles:10 Average:134.20 Median:126.50 stddev:17.11 (13.5%) stddev-sans-first:17.51 03:21:15 INFO - PID 20594 | Values: 147.0 123.0 123.0 174.0 125.0 123.0 125.0 125.0 149.0 128.0 03:21:15 INFO - PID 20594 | 03:21:15 INFO - PID 20594 | [#2] audio-dft Cycles:10 Average:166.40 Median:166.50 stddev:3.81 (2.3%) stddev-sans-first:3.94 03:21:15 INFO - PID 20594 | Values: 164.0 164.0 164.0 169.0 166.0 173.0 172.0 167.0 162.0 163.0 03:21:15 INFO - PID 20594 | 03:21:15 INFO - PID 20594 | [#3] audio-fft Cycles:10 Average:80.30 Median:75.00 stddev:12.25 (16.3%) stddev-sans-first:12.78 03:21:15 INFO - PID 20594 | Values: 74.0 74.0 74.0 110.0 76.0 76.0 74.0 75.0 95.0 75.0 03:21:15 INFO - PID 20594 | 03:21:15 INFO - PID 20594 | [#4] audio-oscillator Cycles:10 Average:89.60 Median:83.00 stddev:11.59 (14.0%) stddev-sans-first:12.11 03:21:15 INFO - PID 20594 | Values: 84.0 82.0 113.0 83.0 83.0 82.0 99.0 83.0 82.0 105.0 03:21:15 INFO - PID 20594 | 03:21:15 INFO - PID 20594 | [#5] imaging-gaussian-blur Cycles:10 Average:115.00 Median:115.00 stddev:1.33 (1.2%) stddev-sans-first:1.36 03:21:15 INFO - PID 20594 | Values: 114.0 114.0 114.0 114.0 116.0 118.0 116.0 115.0 114.0 115.0 03:21:15 INFO - PID 20594 | 03:21:15 INFO - PID 20594 | [#6] imaging-darkroom Cycles:10 Average:151.30 Median:151.50 stddev:0.67 (0.4%) stddev-sans-first:0.67 03:21:15 INFO - PID 20594 | Values: 152.0 151.0 152.0 150.0 151.0 151.0 152.0 151.0 152.0 151.0 03:21:15 INFO - PID 20594 | 03:21:15 INFO - PID 20594 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.79 (0.8%) stddev-sans-first:0.83 03:21:15 INFO - PID 20594 | Values: 95.0 95.0 95.0 94.0 94.0 96.0 94.0 96.0 94.0 95.0 03:21:15 INFO - PID 20594 | 03:21:15 INFO - PID 20594 | [#8] json-parse-financial Cycles:10 Average:56.00 Median:56.00 stddev:1.15 (2.1%) stddev-sans-first:0.97 03:21:15 INFO - PID 20594 | Values: 54.0 55.0 58.0 55.0 56.0 57.0 56.0 56.0 57.0 56.0 03:21:15 INFO - PID 20594 | 03:21:15 INFO - PID 20594 | [#9] json-stringify-tinderbox Cycles:10 Average:56.80 Median:56.50 stddev:1.32 (2.3%) stddev-sans-first:1.36 03:21:15 INFO - PID 20594 | Values: 56.0 57.0 56.0 56.0 57.0 56.0 56.0 56.0 58.0 60.0 03:21:15 INFO - PID 20594 | 03:21:15 INFO - PID 20594 | [#10] stanford-crypto-aes Cycles:10 Average:90.80 Median:87.00 stddev:12.04 (13.8%) stddev-sans-first:12.70 03:21:15 INFO - PID 20594 | Values: 87.0 87.0 86.0 87.0 86.0 87.0 89.0 87.0 125.0 87.0 03:21:15 INFO - PID 20594 | 03:21:15 INFO - PID 20594 | [#11] stanford-crypto-ccm Cycles:10 Average:134.20 Median:135.00 stddev:2.35 (1.7%) stddev-sans-first:2.47 03:21:15 INFO - PID 20594 | Values: 135.0 134.0 131.0 137.0 138.0 135.0 132.0 134.0 131.0 135.0 03:21:15 INFO - PID 20594 | 03:21:15 INFO - PID 20594 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:193.00 Median:194.50 stddev:5.21 (2.7%) stddev-sans-first:4.39 03:21:15 INFO - PID 20594 | Values: 184.0 193.0 202.0 195.0 195.0 194.0 193.0 185.0 193.0 196.0 03:21:15 INFO - PID 20594 | 03:21:15 INFO - PID 20594 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:74.10 Median:74.50 stddev:2.13 (2.9%) stddev-sans-first:2.26 03:21:15 INFO - PID 20594 | Values: 74.0 73.0 71.0 75.0 72.0 76.0 72.0 77.0 74.0 77.0 03:21:15 INFO - PID 20594 | -------- Summary: end -------- 03:21:15 INFO - PID 20594 | 03:21:16 INFO - TEST-INFO | 20594: exit 0 03:21:16 INFO - TEST-OK | kraken | took 92682ms 03:21:16 INFO - SUITE-END | took 1240s 03:21:17 INFO - Completed test suite (00:20:41) 03:21:17 INFO - javascript benchmark 03:21:17 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6656.288458382285, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2725.250556097073, 2738.493378724936, 2740.9588856167147, 2754.0, 2771.1686494051787, 5154.768035438405, 5315.0, 5322.201669749539, 5354.598405119617, 5356.491133342336, 5225.399079105894, 5248.71132087735, 5270.683758974465, 5332.680039197651, 5388.084025715628, 4698.365720627706, 4727.432708075035, 4751.429828420586, 4758.857234282959, 4797.304390863323, 4734.289856521515, 4738.620910327183, 4804.039192161565, 4810.39870016248, 4863.489333619972, 4595.954040459619, 4618.445786505607, 4733.455652599961, 4764.2615394613895, 4815.855524334275, 4709.740964246965, 4742.478327383985, 4771.9522804772205, 4779.354787103766, 4783.0, 4690.999999999965, 4700.976495117503, 4707.71753694776, 4715.24556071027, 4758.476567577563, 5105.412877519096, 5289.2859463972645, 5320.840374788762, 5324.068288049614, 5345.33183352081, 5630.268065151504, 5644.491995720405, 5748.626339287975, 5755.30936287644, 5764.279465066867, 5793.159991801165, 5799.884002319972, 5800.0, 5813.534917206655, 5848.912266316009, 5366.436524164985, 5371.785128594852, 5379.300690910157, 5380.811671591554, 5385.461453854583, 5760.279965004374, 5795.710214489259, 5802.767889284466, 5836.095405212199, 5939.821805345847, 5614.831555053355, 5616.9157462638095, 5634.577406694432, 5650.660960342392, 5669.036263835158, 5735.311762588516, 5739.62692424991, 5755.3381361143165, 5761.308642962871, 5772.711364431846, 5550.888982220333, 5615.578831587565, 5740.540756739534, 5740.856478587985, 5742.16738572913, 5611.158326251095, 5653.632513886584, 5719.142128680731, 5735.168400581976, 5743.8851222976145, 4793.089313030583, 4806.615470762331, 4824.107540105092, 4824.300476430968, 4862.41651001882, 3999.4800675911947, 4107.8973025674, 4113.814878330482, 4114.259433301974, 4143.109231515239, 4787.640926930494, 4834.154023045953, 4852.417709874838, 4877.804887804448, 4911.312416261726, 5762.222100016528, 5779.682117483495, 5793.449622285876, 5795.971020144872, 5797.536197104221, 4837.250226214942, 4873.829415970424, 4878.341423907798, 4880.048390563877, 4909.0, 4941.135301322254, 5003.54968052877, 5055.317532133115, 5115.462876397999, 5125.436202017775, 5344.278522399426, 5349.866253343542, 5360.812371566976, 5373.220882972026, 5415.458454154553, 5601.29983752031, 5684.0, 5772.134179873053, 5782.508486778671, 5792.044312688359, 5237.554807841376, 5269.947300527099, 5300.416954135119, 5376.247325374373, 5401.3248343957, 5523.420040895809, 5707.9429205709075, 5716.056850619601, 5717.656940583578, 5742.827715168552, 5682.602217844711, 5701.344345400166, 5723.31320241557, 5745.1382292656435, 5811.389804070681, 5571.1086226203615, 5578.804741834017, 5604.747786349542, 5606.467385598362, 5647.576431767552, 5569.66582005081, 5569.693666848362, 5570.415106413769, 5573.052581061311, 5578.665280083208, 5350.357957045179, 5414.106672399168, 5471.972640136773, 5488.4237155098135, 5566.944330556643, 5647.661140331429, 5652.434756524314, 5656.519195868397, 5665.49010589049, 5666.405027472056, 5409.918851217313, 5430.995265875826, 5441.347038355423, 5458.426865179258, 5468.015757163748], "value": 5192.584873869152, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [611.1077826373495, 672.1900110367006, 688.3667026335772, 1050.7740835720324, 1059.369675043349, 30549.0, 31525.211869703213, 31526.527102093485, 31593.21016974577, 31602.525962110587, 29769.702302976963, 30056.248593785112, 30100.698993010064, 30118.34349110798, 30195.396092078146, 6258.718357673915, 6389.680515974206, 6484.513661475385, 6591.670416479157, 6652.93347066528, 6527.314631963623, 6538.8692226155445, 6598.241202261754, 6613.900791488131, 6622.8675426491445, 6590.209174899019, 6609.570377925444, 6633.933660663404, 6662.866742665144, 6664.500162487809, 6555.0, 6607.174103237096, 6631.535792494527, 6633.900491492632, 6640.867182656368, 6591.6704164792045, 6594.472442204612, 6619.073329733841, 6634.469242460592, 6638.800835974928, 29040.41919161626, 29127.41745165106, 29165.125046248646, 29192.708072919213, 29271.41457170866, 2654.296611397981, 2686.355274734069, 2687.0, 2687.3953360493733, 2694.1648089092446, 23023.19418820333, 23039.539209215724, 23051.0, 23095.53808923829, 23115.653265201036, 3011.909642710722, 3013.6534298555725, 3021.6827233140643, 3049.710277523654, 3069.9539506907413, 152627.0, 152655.0, 152881.0, 156225.0, 161197.19401403036, 33405.83297083499, 33599.0, 33604.32791344159, 33605.83197083999, 33739.83130084334, 34867.476987845206, 34881.65118348784, 34892.30215395678, 34952.12619684528, 37303.0, 11495.827562586568, 11601.76796464066, 11612.94193529027, 11618.76762464763, 11623.12826538013, 9324.440533568008, 9357.485338306458, 9365.578548965177, 9368.250539956787, 9385.0, 10889.292196007393, 10988.395638239974, 11007.229493935347, 11166.0, 11213.775724485464, 4630.490646028934, 4697.242206234999, 4725.574698277172, 4740.360051393087, 4764.928526072112, 790.9525428474195, 815.6492708135559, 824.5382585751878, 825.8224481736455, 829.6100832608664, 19659.60680786405, 19738.0, 20213.898930505253, 20866.895665521577, 21040.368788936357, 848.499385362639, 859.6819176904586, 873.157403105993, 899.2895612466209, 899.8965119011398, 10163.898361016443, 10317.587296508056, 10909.509072091774, 11009.504572294267, 11086.390248536247, 173305.0, 175008.0, 175523.0, 175537.0, 175950.0, 34919.0, 35138.64861351405, 35164.82417587896, 35217.0, 35224.0, 1056.529844219315, 1079.9136069114452, 1084.734240111162, 1093.9726506837392, 1102.5148934468807, 18482.537936551693, 23213.651795223424, 24858.875705621354, 24953.500929981663, 25344.746552534238, 31466.0, 32146.517802232516, 32164.195895101875, 32177.230252336347, 37166.62833371632, 163898.0, 164580.0, 164750.0, 165431.0, 165866.0, 26935.730642694107, 27063.0, 27131.1860644181, 27205.183844484698, 27255.59116613292, 30511.847440762653, 31375.0, 31537.684623153476, 31584.526232106997, 31616.683833161373, 23833.183598306616, 24492.265232043068, 24921.376965576004, 24994.250172494852, 25606.743932560435, 24253.393665158514, 24785.50428991446, 25149.497010060062, 25267.0, 26218.08236711706, 26819.195424137306, 27191.0, 27440.588391173747, 27467.31331716723, 27876.581851272655, 23871.40321491907, 24294.392640184138, 24577.75422245826, 24618.507629846943, 25107.121250756136, 18845.21572233967, 21087.683684745047, 21203.46991325229, 21263.0, 21678.566428671653], "value": 13527.797180025895, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [361.61307401080836, 366.5912507554077, 366.96146904575016, 372.804277754179, 383.2947376826638, 16876.15619219039, 17465.738013929786, 17477.475675729733, 17490.912545437288, 17522.561935951577, 16288.185590720475, 16738.079405632685, 16957.3217071317, 16973.57566060849, 16985.235664395103, 5487.478689524499, 5623.437656234385, 5624.268845050137, 5634.352049514297, 5649.745761440725, 5414.269073675043, 5449.972750136244, 5460.126379779236, 5461.481159289861, 5467.0, 5376.193570964348, 5403.486668766461, 5419.214213938976, 5427.83716488506, 5433.565314774828, 5271.0, 5402.054640437927, 5413.215083812845, 5434.429384914586, 5471.616986810925, 4927.852164435073, 4937.753112344369, 4944.925826112575, 4957.058158949788, 4957.950420495785, 21346.252881149085, 21713.0, 21750.782492175193, 21775.782242177534, 21822.23622173232, 1640.2372896603017, 1655.4371513685285, 1661.086402478632, 1666.308481979977, 1666.8749843761645, 14417.062890912162, 14782.0, 14854.108753474718, 14855.108693478318, 14903.478378256817, 2009.6282187795305, 2121.6817477378363, 2125.096833845625, 2131.1794958940764, 2146.527763891941, 104514.47742761314, 105989.0, 108252.0, 111449.0, 112166.0, 10294.485275736184, 10414.16686665065, 10671.679849604525, 10672.519736611872, 10799.67600971972, 14075.859241407456, 14153.433862645585, 14162.504312349225, 14168.291585420688, 14174.291285435687, 7310.195878453366, 7312.524685895506, 7333.0, 7530.811729706801, 7728.304452599293, 6819.659017049128, 6829.965850170717, 6865.210500792373, 6920.792376228721, 6936.895946560806, 6714.697838597275, 6792.456603471809, 6797.388235058868, 6810.421114205348, 6836.145481814773, 1800.5138612574794, 1801.9909900450414, 1807.6746185686702, 1809.9457016289268, 1991.074150520015, 799.132940759271, 812.3501199040744, 816.7141500474905, 819.6311659753135, 826.4999675196419, 16664.16679166037, 16695.833041669426, 16698.58253543671, 16963.491095266916, 17066.0, 812.4312980913385, 817.5912043978011, 817.7424111404888, 819.2708489444399, 834.0192043895747, 9203.117909026067, 9413.246940244764, 9708.708738737849, 9728.708138755848, 9749.951250243845, 343272.0, 347685.0, 348519.0, 348750.0, 354015.0, 79741.20258797453, 81017.18982810214, 83496.16503835005, 84169.0, 84989.57505212435, 911.284641556375, 946.5551190940384, 970.3062310447923, 975.0931633580838, 989.5299732627088, 18042.72935905936, 18198.181081851082, 18534.351297704514, 18842.52893677669, 18885.527861803566, 45455.318170228136, 45663.0, 45777.16891324443, 45940.54059459363, 46566.53433465622, 55302.170467442214, 56039.439605603424, 56208.0, 56919.0, 56949.71525142348, 9124.863127052966, 9125.22435592982, 9189.356745027784, 9241.768955776159, 9268.629254829732, 15583.06501609907, 15599.766003510184, 15678.764818527503, 15679.764803527729, 15709.607259818597, 13101.606951791462, 13126.737465250451, 13271.867281327062, 13364.0, 13406.0, 11449.942750286194, 11950.462229199533, 12124.696307701508, 12286.692832679255, 12896.871031289567, 12939.805902911276, 13557.186568805902, 13722.931385343409, 13818.170909745448, 13826.861731382558, 9310.581023854078, 9374.531273436438, 9379.718608441757, 9431.434113953184, 9442.339036267394, 12104.490055182845, 12181.939090304491, 12226.755464890475, 12251.142420030512, 12252.632421027383], "value": 9058.10150940691, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1076.8330908709147, 1104.5140138339125, 1125.8367536707171, 1126.892945170209, 1141.9885801141986, 9847.409155450678, 10148.949255253732, 10329.431881246528, 10340.896591034098, 10465.05814476697, 10016.198704103672, 10122.898771012287, 10147.137493313077, 10227.948860255707, 10242.77086749591, 2115.9894200529016, 2148.495103650641, 2158.6330323844904, 2167.2631305356176, 2168.327818376308, 2142.3465842917904, 2172.934811955644, 2173.5326904715484, 2178.3900507857825, 2179.182806447582, 2108.188347486221, 2127.7765834587376, 2136.519283161284, 2143.185589475997, 2147.0552956699003, 2071.4510654676524, 2077.3248694174376, 2079.6690118324286, 2086.739157605299, 2090.6341390256644, 1787.5977904971407, 1855.8422534084618, 2048.047657839097, 2055.219016773631, 2160.79472450117, 10318.638847640372, 10391.948040259826, 10458.215633827418, 10464.52909619069, 10508.842367364496, 5231.5291623753665, 5456.972715136439, 5458.044842152607, 5460.481254280837, 5460.645058071213, 3071.6467606225124, 3196.1530194498478, 3254.170186602425, 3255.6744325567493, 3256.625488068879, 989.5893204320198, 999.6651121874108, 1007.5566750629773, 1017.1201910347496, 1022.504085518523, 15245.695086098327, 15267.770983435257, 15270.694586108326, 15411.075335479907, 15468.613284667861, 4447.266201076786, 4452.220861349251, 4472.530384309601, 4592.494825569184, 4594.759414958009, 10798.51406686701, 10833.404162770965, 10850.131989440826, 10892.782144357068, 10915.39965301916, 4887.682300650446, 4958.776855041532, 4983.6013118950395, 5004.2493625956395, 5004.649674522821, 4589.173948689201, 4611.930821037688, 4632.536746325341, 4647.256438969816, 4649.814007439732, 3617.620149884277, 3634.109643137448, 3699.260147970363, 3745.4007358823, 3765.3034188675183, 990.1039559198792, 1007.8790545134631, 1022.483645758887, 1025.6512785652765, 1029.2177944761886, 627.5159248377554, 645.954325355949, 656.136808978085, 661.0879077662903, 661.6129564204898, 5746.741396637078, 5833.88332233353, 5842.065269556935, 5861.941380586225, 6074.42292982166, 757.6817736550662, 774.8489044636354, 778.7858338956719, 791.6081539637917, 806.5120602035802, 3668.1746607013743, 3672.4674922136674, 3688.5389326334207, 3739.4390841373465, 3757.1170774867883, 13239.139455935334, 13392.799108013387, 14063.0, 14073.437062517385, 14077.577672669837, 13823.79264311016, 14004.509842155476, 14158.29208539569, 14173.929130354281, 14187.219702916438, 7193.64031798408, 7539.585322807298, 7603.543787372775, 7610.1628820829665, 7644.006279183671, 5894.528437724886, 5934.169216309634, 5955.583109182316, 6008.309044459943, 6237.500999919905, 12114.394280285775, 12288.938555307166, 12432.191907525981, 12439.191452555555, 12487.812682809583, 12519.561815336783, 12533.185342952678, 12569.685757855761, 12698.809517857424, 12774.936125319315, 8255.793605159919, 8315.201117876084, 8334.791630209293, 8402.915970840213, 8412.62143203545, 9625.32622716403, 9642.228621710387, 9681.128698417177, 9686.951565242129, 9722.125008749246, 8128.471649342774, 8199.754007379788, 8208.876866847122, 8275.089740128702, 8358.247757701836, 7729.420293478124, 7758.883616745867, 7779.688812447665, 7869.763907082796, 7887.9605601971625, 7241.746538871325, 7254.927450725636, 7294.1247050354295, 7316.561006339423, 7364.0, 4545.227311357144, 5255.343082114736, 5335.359756829205, 5365.061114305059, 5416.808302173516, 5165.276861239355, 5231.29377534028, 5232.450592687713, 5284.203370853928, 5297.841064768063], "value": 4624.160678667865, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [338.50578155892396, 346.44568690095866, 350.5688003755382, 359.2653024564765, 364.2805459218044, 5617.21359009739, 5650.898074875401, 5656.264685590872, 5699.68651724155, 5701.885962280757, 5491.313585801775, 5505.421930697269, 5537.750801213945, 5539.501444869961, 5569.220309156722, 3996.920061598766, 4126.360414135814, 4126.896827579305, 4129.174165166979, 4130.752154870703, 4110.342345224764, 4126.628603425691, 4141.6065473779945, 4144.295469770132, 4144.41978123063, 4077.938830917539, 4080.469538959931, 4081.795910204493, 4086.162336720965, 4101.446304748865, 4080.245154646385, 4082.1835632873544, 4104.117614712821, 4106.29588720682, 4106.815193316308, 3578.7315951303494, 3581.176329444216, 3581.8567257309937, 3590.8204589770667, 3597.5143355647174, 5401.78392864285, 5403.621746477748, 5411.080116380225, 5418.620696551243, 5457.208704737791, 4883.536064073943, 4887.780049897728, 4890.535399137077, 4910.312556242129, 4913.385826771653, 5848.982101175087, 5857.912131318034, 5874.706264686749, 5878.882422351529, 5882.882342353129, 4034.495688038995, 4036.777977211252, 4037.4953130858644, 4039.798010099513, 4040.313146765028, 5801.30384353876, 6206.441420272197, 6252.0, 6276.184096067527, 6305.369463053704, 4033.9394909076386, 4048.554658987509, 4050.8177132029127, 4061.289274376972, 4100.938485922714, 4119.237940980928, 4135.255653982312, 4138.730982486129, 4139.048018955657, 4139.275626765304, 4716.952830471651, 4814.711117332971, 4820.4456487503685, 4833.854984350475, 4836.854894353175, 5837.9124313135335, 5851.853703657443, 5865.677387743715, 5884.705764711747, 5894.233749612608, 1421.7938398932304, 1453.5203382883624, 1453.9200343981183, 1454.280131334996, 1459.058907004997, 912.0104686415314, 946.9914541013799, 950.1828427552299, 951.2295041016798, 951.785848184153, 5027.84916452507, 5068.873278168076, 5083.186690129635, 5090.0583392072585, 5103.87240318995, 6068.605540639845, 6079.179310792986, 6092.557704896808, 6119.326874043852, 6139.877202456015, 5046.39443266803, 5067.138586440314, 5075.360812377543, 5082.364704411949, 5101.668391554611, 3220.533022711694, 3223.6615155408813, 3249.6425393206728, 3250.9837450813066, 3256.1859535116223, 5626.803061892896, 5638.0, 5656.462636049569, 5658.490735833712, 5671.2060311556415, 6245.96877015612, 6249.312575616678, 6256.937430625727, 6275.0, 6287.9056814147825, 5629.324481062299, 5647.322321321386, 5666.886662266732, 5674.347450043216, 5694.117411801178, 6088.4215999479975, 6092.268927728701, 6105.45050945417, 6124.724387402489, 6151.169592105009, 5989.880202396015, 6002.969985150046, 6003.759849606142, 6013.488853447506, 6033.456988871023, 5283.339582552181, 5432.728363581884, 5525.171224316385, 5640.407757185437, 5652.830415087554, 4011.318075927041, 4062.6546743527133, 4079.449274347925, 4091.2635725569685, 4101.077257617012, 6094.2077529920825, 6097.664628445478, 6119.0, 6123.142760013513, 6141.631502109888, 5723.599348045597, 5868.295804503487, 5888.352281249145, 5898.616589921641, 5900.023492130184, 5855.560832937462, 5859.472647461749, 5890.617109887844, 5894.970525147347, 5909.497692696169, 5833.329167145833, 5851.824445266649, 5855.970720146372, 5864.736086876186, 5889.0, 5964.194833697396, 5964.552658550713, 5970.97014514942, 5989.550783691154, 6014.188084608521, 5756.798512052058, 5764.164196191445, 5785.30576330843, 5801.158831969426, 5811.128330750421], "value": 4355.100783587975, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [629.981100566983, 638.4828289085841, 642.7718160053181, 643.4498503779272, 647.8412788866729, 12936.353182340881, 13295.800562991562, 13367.532136375228, 15449.150296733675, 16833.15834208288, 14787.186704731263, 14972.251387430611, 14989.100653960742, 14989.400423983056, 14991.175485348302, 641.5380925733476, 646.1535388640872, 647.8380404898776, 648.3775575447553, 650.681166228547, 647.6826355085998, 651.4723074309801, 658.9439897608709, 671.493022767812, 747.5552046532305, 685.8868286732683, 693.3205458650525, 693.3413257405459, 693.9763848323732, 694.0248950224917, 680.3026897430125, 684.9931500685029, 687.2714922182503, 687.9140107486564, 690.2097098821846, 497.46025562264987, 504.684572142411, 512.8076971135824, 513.6147889083188, 529.9576033917277, 13486.39311230997, 13765.793513097311, 13809.0, 13828.585142445743, 13861.930690346584, 14169.645758856112, 15146.0, 15371.769423458545, 15453.304601292968, 15457.536273911688, 12225.327606981613, 12514.374281285991, 12663.796939290753, 12675.492980280778, 12806.0, 2958.4378967996013, 2980.2549362659333, 2980.5678176664264, 2986.462436761382, 2986.5221564549784, 86592.56703716441, 87550.562247189, 88070.55964720136, 88374.11625883722, 89356.5532172335, 11890.881091188978, 11994.220375675728, 12168.69578260533, 12188.20776649515, 12230.205036672587, 20092.296769612993, 20286.0, 20844.478888027617, 20849.166033358495, 20900.0, 6285.214348206474, 6305.873882522415, 6327.114204011442, 6359.841003974938, 6371.776987805404, 2869.727375899286, 2869.9856500717365, 2915.8833646653898, 2945.4109178164026, 2978.3149875528316, 3343.0, 3406.0, 3417.4019546579248, 3432.845521951518, 3445.586529616462, 718.90294810201, 736.4513437488998, 738.4092725819323, 739.6227923758814, 739.8113481062402, 545.6235197713565, 571.4799532425473, 571.6655756382563, 572.8596493858948, 576.3746335226242, 9933.801323973625, 10331.793364132674, 10603.0, 10681.11609865332, 11432.0, 561.4525837308673, 571.6398668838605, 571.8484601580584, 575.2694078520256, 588.6879953624585, 4128.649064829463, 4218.7679677618025, 4292.978535107367, 4338.154059958341, 4680.251159814481, 76697.61651191708, 77419.0, 77940.22059779329, 78568.607156965, 80164.59917700491, 64025.35974640287, 64830.67584662046, 65731.67134164298, 65872.34127658662, 69851.65074174597, 58578.414215857294, 59349.406505934385, 59859.700701496215, 60807.0, 61767.0, 9222.262219022328, 9261.351705380828, 9405.529723513933, 9447.433154010781, 10300.381977081399, 32050.519242210918, 32084.35831283408, 32567.674323256466, 33275.16812079717, 33734.0, 57173.428265718474, 57749.422505774404, 57861.0, 60427.395726042174, 61055.694721527885, 13435.462581497022, 13778.862211377758, 13968.092074015156, 14004.36980335867, 14149.08030977983, 16049.0, 16295.837041629906, 16476.505704828873, 16637.168141593113, 16699.91650041742, 14557.272136392927, 14726.0, 14929.477468288558, 15063.397464101752, 15184.696306073596, 14222.502212422516, 14523.419063237352, 14596.12423254608, 14626.488072917396, 14728.337224824694, 13407.396667149807, 14270.71458570802, 14346.856531434552, 14409.495667651581, 14749.631259218177, 10366.0, 10411.745772363702, 10881.945590271998, 11112.22214444981, 11143.83284250753, 11075.889241107487, 11536.134789890624, 11656.125790565571, 11858.0, 11863.703407414883], "value": 6787.095787031787, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1546.6999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 111.0, 110.0, 109.0, 110.0, 109.0, 111.0, 112.0, 114.0, 113.0], "value": 110.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 123.0, 123.0, 174.0, 125.0, 123.0, 125.0, 125.0, 149.0, 128.0], "value": 134.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 164.0, 164.0, 169.0, 166.0, 173.0, 172.0, 167.0, 162.0, 163.0], "value": 166.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 74.0, 110.0, 76.0, 76.0, 74.0, 75.0, 95.0, 75.0], "value": 80.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 82.0, 113.0, 83.0, 83.0, 82.0, 99.0, 83.0, 82.0, 105.0], "value": 89.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 114.0, 114.0, 116.0, 118.0, 116.0, 115.0, 114.0, 115.0], "value": 115.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 151.0, 152.0, 150.0, 151.0, 151.0, 152.0, 151.0, 152.0, 151.0], "value": 151.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 94.0, 94.0, 96.0, 94.0, 96.0, 94.0, 95.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 55.0, 58.0, 55.0, 56.0, 57.0, 56.0, 56.0, 57.0, 56.0], "value": 56.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 57.0, 56.0, 56.0, 57.0, 56.0, 56.0, 56.0, 58.0, 60.0], "value": 56.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 87.0, 86.0, 87.0, 86.0, 87.0, 89.0, 87.0, 125.0, 87.0], "value": 90.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 134.0, 131.0, 137.0, 138.0, 135.0, 132.0, 134.0, 131.0, 135.0], "value": 134.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 193.0, 202.0, 195.0, 195.0, 194.0, 193.0, 185.0, 193.0, 196.0], "value": 193.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 73.0, 71.0, 75.0, 72.0, 76.0, 72.0, 77.0, 74.0, 77.0], "value": 74.1, "unit": "score"}]}]} 03:21:17 INFO - Return code: 0 03:21:17 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:21:17 INFO - # TBPL SUCCESS # 03:21:17 INFO - Running post-action listener: _resource_record_post_action 03:21:17 INFO - [mozharness: 2017-05-31 10:21:17.496762Z] Finished run-tests step (success) 03:21:17 INFO - Running post-run listener: _resource_record_post_run 03:21:17 INFO - Total resource usage - Wall time: 1257s; CPU: 13.0%; Read bytes: 0; Write bytes: 411250688; Read time: 0; Write time: 248184 03:21:17 INFO - TinderboxPrint: CPU usage
12.7% 03:21:17 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 03:21:17 INFO - TinderboxPrint: I/O write bytes / time
411,250,688 / 248,184 03:21:17 INFO - TinderboxPrint: CPU idle
8,760.4 (87.3%) 03:21:17 INFO - TinderboxPrint: CPU user
1,221.6 (12.2%) 03:21:17 INFO - TinderboxPrint: Swap in / out
0 / 0 03:21:17 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 95404032; Read time: 0; Write time: 78512 03:21:17 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 03:21:17 INFO - run-tests - Wall time: 1242s; CPU: 13.0%; Read bytes: 0; Write bytes: 315846656; Read time: 0; Write time: 169672 03:21:18 INFO - Running post-run listener: _upload_blobber_files 03:21:18 INFO - Blob upload gear active. 03:21:18 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:21:18 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 03:21:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 03:21:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 03:21:18 INFO - (blobuploader) - INFO - Open directory for files ... 03:21:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:21:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:21:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:21:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:21:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:21:19 INFO - (blobuploader) - INFO - Done attempting. 03:21:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:21:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:21:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:21:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:21:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:21:20 INFO - (blobuploader) - INFO - Done attempting. 03:21:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 03:21:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:21:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:21:21 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 03:21:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:21:21 INFO - (blobuploader) - INFO - Done attempting. 03:21:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:21:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:21:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:21:25 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:21:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:21:25 INFO - (blobuploader) - INFO - Done attempting. 03:21:25 INFO - (blobuploader) - INFO - Iteration through files over. 03:21:25 INFO - Return code: 0 03:21:25 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:21:25 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:21:25 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6ed0ea386674ef6ef60b3785b4618591a2a67bcfd436c430f945dcd4ad7d899d1ae7765332c2cecdfb08ccbdca14db1ff2ee778250f6eedc5250a7212149f7d8", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9127f03595abe466bd93af1b928d0ba00dbdd658df42d1fe7eb663f5896663807fe330208e0a63150dac9d90b222f5274d1bc83578738e173eebaf44b18e4c2b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/801a9e61813fe2559cd610cddcf1c65cd9a75788e321211da37fbdfb39c99689f4ea6dc1db5c3821bde274fe61c99b4f65c2a1da35e55e47b468aac01a1797a7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c18a6459d7c9c88ff02e124ccf16139ae308a1b017ef0d69af5a0937207fd69061561ce0f0aec5f0a87e5c5e7aed74b9d30fa9af1b306aa6854e06a7a3f8cc02"} 03:21:25 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:21:25 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:21:25 INFO - Contents: 03:21:25 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6ed0ea386674ef6ef60b3785b4618591a2a67bcfd436c430f945dcd4ad7d899d1ae7765332c2cecdfb08ccbdca14db1ff2ee778250f6eedc5250a7212149f7d8", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9127f03595abe466bd93af1b928d0ba00dbdd658df42d1fe7eb663f5896663807fe330208e0a63150dac9d90b222f5274d1bc83578738e173eebaf44b18e4c2b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/801a9e61813fe2559cd610cddcf1c65cd9a75788e321211da37fbdfb39c99689f4ea6dc1db5c3821bde274fe61c99b4f65c2a1da35e55e47b468aac01a1797a7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c18a6459d7c9c88ff02e124ccf16139ae308a1b017ef0d69af5a0937207fd69061561ce0f0aec5f0a87e5c5e7aed74b9d30fa9af1b306aa6854e06a7a3f8cc02"} 03:21:25 INFO - Running post-run listener: copy_logs_to_upload_dir 03:21:25 INFO - Copying logs to upload dir... 03:21:25 INFO - mkdir: /builds/slave/test/build/upload/logs 03:21:25 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1316.478329 ========= master_lag: 0.21 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 56 secs) (at 2017-05-31 03:21:25.056045) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-31 03:21:25.059708) ========= 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=3297cc2eebb5444a7688c33f000001b5-1496221020.334826-633799755 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6ed0ea386674ef6ef60b3785b4618591a2a67bcfd436c430f945dcd4ad7d899d1ae7765332c2cecdfb08ccbdca14db1ff2ee778250f6eedc5250a7212149f7d8", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9127f03595abe466bd93af1b928d0ba00dbdd658df42d1fe7eb663f5896663807fe330208e0a63150dac9d90b222f5274d1bc83578738e173eebaf44b18e4c2b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/801a9e61813fe2559cd610cddcf1c65cd9a75788e321211da37fbdfb39c99689f4ea6dc1db5c3821bde274fe61c99b4f65c2a1da35e55e47b468aac01a1797a7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c18a6459d7c9c88ff02e124ccf16139ae308a1b017ef0d69af5a0937207fd69061561ce0f0aec5f0a87e5c5e7aed74b9d30fa9af1b306aa6854e06a7a3f8cc02"} build_url:https://queue.taskcluster.net/v1/task/ZPsXcz3ZRXiFbi_tli0rPA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011431 build_url: 'https://queue.taskcluster.net/v1/task/ZPsXcz3ZRXiFbi_tli0rPA/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6ed0ea386674ef6ef60b3785b4618591a2a67bcfd436c430f945dcd4ad7d899d1ae7765332c2cecdfb08ccbdca14db1ff2ee778250f6eedc5250a7212149f7d8", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9127f03595abe466bd93af1b928d0ba00dbdd658df42d1fe7eb663f5896663807fe330208e0a63150dac9d90b222f5274d1bc83578738e173eebaf44b18e4c2b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/801a9e61813fe2559cd610cddcf1c65cd9a75788e321211da37fbdfb39c99689f4ea6dc1db5c3821bde274fe61c99b4f65c2a1da35e55e47b468aac01a1797a7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c18a6459d7c9c88ff02e124ccf16139ae308a1b017ef0d69af5a0937207fd69061561ce0f0aec5f0a87e5c5e7aed74b9d30fa9af1b306aa6854e06a7a3f8cc02"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-31 03:21:25.084651) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-31 03:21:25.084979) ========= 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=3297cc2eebb5444a7688c33f000001b5-1496221020.334826-633799755 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004506 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-31 03:21:25.169345) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-31 03:21:25.169667) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-31 03:21:25.169973) ========= ========= Total master_lag: 0.36 =========