builder: mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s-pgo slave: talos-linux64-ix-021 starttime: 1506476477.57 results: success (0) revision: 70158e4e215d784d1391db5e517b18727f4b3683 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-26 18:41:17.573457) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-26 18:41:17.573916) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-26 18:41:17.574194) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-26 18:41:17.591772) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-26 18:41:17.592074) ========= 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=df17445c3590ff7897617a0e00000225-1506475638.995008-257981642 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-26 18:41:17-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.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% 224M=0s 2017-09-26 18:41:17 (224 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.125455 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-26 18:41:17.738809) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-26 18:41:17.739289) ========= 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=df17445c3590ff7897617a0e00000225-1506475638.995008-257981642 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016548 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-26 18:41:17.789238) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-09-26 18:41:17.789536) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 70158e4e215d784d1391db5e517b18727f4b3683 --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 70158e4e215d784d1391db5e517b18727f4b3683 --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=df17445c3590ff7897617a0e00000225-1506475638.995008-257981642 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-26 18:41:17,869 truncating revision to first 12 chars 2017-09-26 18:41:17,869 Setting DEBUG logging. 2017-09-26 18:41:17,869 attempt 1/10 2017-09-26 18:41:17,869 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/70158e4e215d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-26 18:41:18,670 unpacking tar archive at: mozilla-central-70158e4e215d/testing/mozharness/ program finished with exit code 0 elapsedTime=1.093199 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-09-26 18:41:18.915304) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-26 18:41:18.915720) ========= script_repo_revision: 70158e4e215d784d1391db5e517b18727f4b3683 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-26 18:41:18.916129) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-26 18:41:18.916431) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-26 18:41:18.943610) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2017-09-26 18:41:18.943931) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-stylo-disabled-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-stylo-disabled-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=df17445c3590ff7897617a0e00000225-1506475638.995008-257981642 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 18:41:19 INFO - MultiFileLogger online at 20170926 18:41:19 in /builds/slave/test 18:41:19 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-stylo-disabled-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 18:41:19 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:41:19 INFO - {'append_to_log': False, 18:41:19 INFO - 'base_work_dir': '/builds/slave/test', 18:41:19 INFO - 'blob_upload_branch': 'Firefox', 18:41:19 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:41:19 INFO - 'branch': 'Firefox', 18:41:19 INFO - 'buildbot_json_path': 'buildprops.json', 18:41:19 INFO - 'code_coverage': False, 18:41:19 INFO - 'config_files': ('talos/linux_config.py',), 18:41:19 INFO - 'default_actions': ('clobber', 18:41:19 INFO - 'read-buildbot-config', 18:41:19 INFO - 'download-and-extract', 18:41:19 INFO - 'populate-webroot', 18:41:19 INFO - 'create-virtualenv', 18:41:19 INFO - 'install', 18:41:19 INFO - 'setup-mitmproxy', 18:41:19 INFO - 'run-tests'), 18:41:19 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:41:19 INFO - 'disable_ccov_upload': False, 18:41:19 INFO - 'disable_stylo': False, 18:41:19 INFO - 'download_minidump_stackwalk': True, 18:41:19 INFO - 'download_symbols': 'ondemand', 18:41:19 INFO - 'enable_stylo': False, 18:41:19 INFO - 'enable_webrender': False, 18:41:19 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 18:41:19 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:41:19 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:41:19 INFO - 'gecko_profile': False, 18:41:19 INFO - 'gecko_profile_interval': 0, 18:41:19 INFO - 'installer_path': 'installer.exe', 18:41:19 INFO - 'log_level': 'info', 18:41:19 INFO - 'log_name': 'talos', 18:41:19 INFO - 'log_to_console': True, 18:41:19 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 18:41:19 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 18:41:19 INFO - 'opt_config_files': (), 18:41:19 INFO - 'pip_index': False, 18:41:19 INFO - 'suite': 'dromaeojs-stylo-disabled-e10s', 18:41:19 INFO - 'system_bits': '32', 18:41:19 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:41:19 INFO - 'title': 'talos-linux64-ix-021', 18:41:19 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:41:19 INFO - 'use_talos_json': True, 18:41:19 INFO - 'verify': 'False', 18:41:19 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:41:19 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:41:19 INFO - 'work_dir': 'build'} 18:41:19 INFO - [mozharness: 2017-09-27 01:41:19.164085Z] Running clobber step. 18:41:19 INFO - Running pre-action listener: _resource_record_pre_action 18:41:19 INFO - Running main action method: clobber 18:41:19 INFO - rmtree: /builds/slave/test/build 18:41:19 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:41:20 INFO - Running post-action listener: _resource_record_post_action 18:41:20 INFO - [mozharness: 2017-09-27 01:41:20.687654Z] Finished clobber step (success) 18:41:20 INFO - [mozharness: 2017-09-27 01:41:20.687752Z] Running read-buildbot-config step. 18:41:20 INFO - Running pre-action listener: _resource_record_pre_action 18:41:20 INFO - Running main action method: read_buildbot_config 18:41:20 INFO - Using buildbot properties: 18:41:20 INFO - { 18:41:20 INFO - "project": "", 18:41:20 INFO - "product": "firefox", 18:41:20 INFO - "who": "kwierso@gmail.com", 18:41:20 INFO - "installer_path": "public/build/target.tar.bz2", 18:41:20 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s", 18:41:20 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 18:41:20 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-stylo-disabled-e10s", 18:41:20 INFO - "stage_platform": "linux64-pgo", 18:41:20 INFO - "basedir": "/builds/slave/test", 18:41:20 INFO - "buildnumber": 64, 18:41:20 INFO - "platform": "ubuntu64_hw", 18:41:20 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 18:41:20 INFO - "slavebuilddir": "test", 18:41:20 INFO - "taskId": "UXWGjwJoRm6c6ehrbLG5AA", 18:41:20 INFO - "branch": "mozilla-central", 18:41:20 INFO - "script_repo_revision": "production", 18:41:20 INFO - "revision": "70158e4e215d784d1391db5e517b18727f4b3683", 18:41:20 INFO - "slavename": "talos-linux64-ix-021", 18:41:20 INFO - "repo_path": "mozilla-central" 18:41:20 INFO - } 18:41:20 INFO - Finding installer, test and symbols from parent task. 18:41:20 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/UXWGjwJoRm6c6ehrbLG5AA'}, attempt #1 18:41:21 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/UXWGjwJoRm6c6ehrbLG5AA'}, attempt #1 18:41:21 INFO - Task dependencies: ViBZ0mWEQlOae9cmg2YqOQ 18:41:21 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ViBZ0mWEQlOae9cmg2YqOQ'}, attempt #1 18:41:22 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/ViBZ0mWEQlOae9cmg2YqOQ/artifacts/public/build/target.tar.bz2 18:41:22 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/ViBZ0mWEQlOae9cmg2YqOQ/artifacts/public/build/target.test_packages.json 18:41:22 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/ViBZ0mWEQlOae9cmg2YqOQ/artifacts/public/build/target.crashreporter-symbols.zip 18:41:22 INFO - Running post-action listener: _resource_record_post_action 18:41:22 INFO - [mozharness: 2017-09-27 01:41:22.326431Z] Finished read-buildbot-config step (success) 18:41:22 INFO - [mozharness: 2017-09-27 01:41:22.326655Z] Running download-and-extract step. 18:41:22 INFO - Running pre-action listener: _resource_record_pre_action 18:41:22 INFO - Running main action method: download_and_extract 18:41:22 INFO - mkdir: /builds/slave/test/build/tests 18:41:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:41:22 INFO - trying https://queue.taskcluster.net/v1/task/ViBZ0mWEQlOae9cmg2YqOQ/artifacts/public/build/target.test_packages.json 18:41:22 INFO - Downloading https://queue.taskcluster.net/v1/task/ViBZ0mWEQlOae9cmg2YqOQ/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 18:41:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ViBZ0mWEQlOae9cmg2YqOQ/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 18:41:23 INFO - Downloaded 989 bytes. 18:41:23 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 18:41:23 INFO - Using the following test package requirements: 18:41:23 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 18:41:23 INFO - u'common': [u'target.common.tests.zip'], 18:41:23 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 18:41:23 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 18:41:23 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 18:41:23 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 18:41:23 INFO - u'mozbase': [u'target.common.tests.zip'], 18:41:23 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 18:41:23 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 18:41:23 INFO - u'web-platform': [u'target.common.tests.zip', 18:41:23 INFO - u'target.web-platform.tests.tar.gz'], 18:41:23 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 18:41:23 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 18:41:23 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ViBZ0mWEQlOae9cmg2YqOQ/artifacts/public/build/target.common.tests.zip 18:41:23 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ViBZ0mWEQlOae9cmg2YqOQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 18:41:23 INFO - Fetch https://queue.taskcluster.net/v1/task/ViBZ0mWEQlOae9cmg2YqOQ/artifacts/public/build/target.common.tests.zip into memory 18:41:24 INFO - Content-Length response header: 55350178 18:41:24 INFO - Bytes received: 55350178 18:41:35 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ViBZ0mWEQlOae9cmg2YqOQ/artifacts/public/build/target.talos.tests.zip 18:41:35 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ViBZ0mWEQlOae9cmg2YqOQ/artifacts/public/build/target.talos.tests.zip'}, attempt #1 18:41:35 INFO - Fetch https://queue.taskcluster.net/v1/task/ViBZ0mWEQlOae9cmg2YqOQ/artifacts/public/build/target.talos.tests.zip into memory 18:41:37 INFO - Content-Length response header: 14513823 18:41:37 INFO - Bytes received: 14513823 18:41:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:41:37 INFO - trying https://queue.taskcluster.net/v1/task/ViBZ0mWEQlOae9cmg2YqOQ/artifacts/public/build/target.tar.bz2 18:41:37 INFO - Downloading https://queue.taskcluster.net/v1/task/ViBZ0mWEQlOae9cmg2YqOQ/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 18:41:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ViBZ0mWEQlOae9cmg2YqOQ/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 18:41:40 INFO - Downloaded 62333709 bytes. 18:41:40 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ViBZ0mWEQlOae9cmg2YqOQ/artifacts/public/build/target.tar.bz2 18:41:40 INFO - mkdir: /builds/slave/test/properties 18:41:40 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:41:40 INFO - Writing to file /builds/slave/test/properties/build_url 18:41:40 INFO - Contents: 18:41:40 INFO - build_url:https://queue.taskcluster.net/v1/task/ViBZ0mWEQlOae9cmg2YqOQ/artifacts/public/build/target.tar.bz2 18:41:40 INFO - Running post-action listener: _resource_record_post_action 18:41:40 INFO - Running post-action listener: find_tests_for_verification 18:41:40 INFO - Running post-action listener: set_extra_try_arguments 18:41:40 INFO - [mozharness: 2017-09-27 01:41:40.843617Z] Finished download-and-extract step (success) 18:41:40 INFO - [mozharness: 2017-09-27 01:41:40.843755Z] Running populate-webroot step. 18:41:40 INFO - Running pre-action listener: _resource_record_pre_action 18:41:40 INFO - Running main action method: populate_webroot 18:41:40 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 18:41:40 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 18:41:40 INFO - 'tests': ['tresize', 18:41:40 INFO - 'tcanvasmark']}, 18:41:40 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 18:41:40 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 18:41:40 INFO - 'tests': ['dromaeo_css', 18:41:40 INFO - 'kraken']}, 18:41:40 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 18:41:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:41:40 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 18:41:40 INFO - 'talos_options': ['--disable-stylo'], 18:41:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:41:40 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 18:41:40 INFO - 'tests': ['damp', 'tps']}, 18:41:40 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 18:41:40 INFO - 'talos_options': ['--disable-stylo'], 18:41:40 INFO - 'tests': ['damp', 'tps']}, 18:41:40 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:41:40 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 18:41:40 INFO - 'tests': ['dromaeo_dom']}, 18:41:40 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 18:41:40 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 18:41:40 INFO - 'tests': ['basic_compositor_video', 18:41:40 INFO - 'glvideo']}, 18:41:40 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 18:41:40 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 18:41:40 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 18:41:40 INFO - 'talos_options': ['--disable-stylo'], 18:41:40 INFO - 'tests': ['ts_paint_webext', 18:41:40 INFO - 'tp5o_webext']}, 18:41:40 INFO - 'other-e10s': {'tests': ['a11yr', 18:41:40 INFO - 'ts_paint', 18:41:40 INFO - 'tpaint', 18:41:40 INFO - 'sessionrestore', 18:41:40 INFO - 'sessionrestore_many_windows', 18:41:40 INFO - 'sessionrestore_no_auto_restore', 18:41:40 INFO - 'tabpaint']}, 18:41:40 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 18:41:40 INFO - 'tests': ['a11yr', 18:41:40 INFO - 'ts_paint', 18:41:40 INFO - 'tpaint', 18:41:40 INFO - 'sessionrestore', 18:41:40 INFO - 'sessionrestore_many_windows', 18:41:40 INFO - 'sessionrestore_no_auto_restore', 18:41:40 INFO - 'tabpaint']}, 18:41:40 INFO - 'perf-reftest-e10s': {'tests': ['perf_reftest']}, 18:41:40 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 18:41:40 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 18:41:40 INFO - 'tests': ['perf_reftest_singletons']}, 18:41:40 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 18:41:40 INFO - 'tests': ['perf_reftest']}, 18:41:40 INFO - 'svgr-e10s': {'tests': ['tsvgx', 18:41:40 INFO - 'tsvgr_opacity', 18:41:40 INFO - 'tart', 18:41:40 INFO - 'tscrollx', 18:41:40 INFO - 'tsvg_static']}, 18:41:40 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 18:41:40 INFO - 'tests': ['tsvgx', 18:41:40 INFO - 'tsvgr_opacity', 18:41:40 INFO - 'tart', 18:41:40 INFO - 'tscrollx', 18:41:40 INFO - 'tsvg_static']}, 18:41:40 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 18:41:40 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 18:41:40 INFO - 'talos_options': ['--disable-stylo'], 18:41:40 INFO - 'tests': ['tp5o']}, 18:41:40 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 18:41:40 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 18:41:40 INFO - 'talos_options': ['--mitmproxy', 18:41:40 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 18:41:40 INFO - '--firstNonBlankPaint'], 18:41:40 INFO - 'tests': ['tp6_google', 18:41:40 INFO - 'tp6_youtube', 18:41:40 INFO - 'tp6_amazon', 18:41:40 INFO - 'tp6_facebook']}, 18:41:40 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 18:41:40 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 18:41:40 INFO - 'talos_options': ['--disable-stylo', 18:41:40 INFO - '--mitmproxy', 18:41:40 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 18:41:40 INFO - '--firstNonBlankPaint'], 18:41:40 INFO - 'tests': ['tp6_google', 18:41:40 INFO - 'tp6_youtube', 18:41:40 INFO - 'tp6_amazon', 18:41:40 INFO - 'tp6_facebook']}, 18:41:40 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 18:41:40 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 18:41:40 INFO - 'talos_options': ['--stylo-threads=1', 18:41:40 INFO - '--mitmproxy', 18:41:40 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 18:41:40 INFO - '--firstNonBlankPaint'], 18:41:40 INFO - 'tests': ['tp6_google', 18:41:40 INFO - 'tp6_youtube', 18:41:40 INFO - 'tp6_amazon', 18:41:40 INFO - 'tp6_facebook']}, 18:41:40 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 18:41:40 INFO - 'talos_options': ['--xperf_path', 18:41:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:41:40 INFO - 'tests': ['tp5n']}, 18:41:40 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 18:41:40 INFO - 'talos_options': ['--disable-stylo', 18:41:40 INFO - '--xperf_path', 18:41:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:41:40 INFO - 'tests': ['tp5n']}}} 18:41:40 INFO - Running post-action listener: _resource_record_post_action 18:41:40 INFO - [mozharness: 2017-09-27 01:41:40.861772Z] Finished populate-webroot step (success) 18:41:40 INFO - [mozharness: 2017-09-27 01:41:40.861862Z] Running create-virtualenv step. 18:41:40 INFO - Running pre-action listener: _resource_record_pre_action 18:41:40 INFO - Running main action method: create_virtualenv 18:41:40 INFO - Creating virtualenv /builds/slave/test/build/venv 18:41:40 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 18:41:40 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 18:41:40 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 18:41:40 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:41:40 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:41:41 INFO - Installing distribute.............................................................................................................................................................................................done. 18:41:41 INFO - Installing pip...............done. 18:41:41 INFO - Return code: 0 18:41:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 18:41:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 18:41:41 INFO - Reading from file tmpfile_stdout 18:41:41 INFO - Output received: 18:41:41 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 18:41:41 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:41:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:41:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:41:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:41:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:41:41 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 0x19511f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b19b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cbe9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cbbd60>, '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 0x1cbca60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cbcef0>, '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': 'df17445c3590ff7897617a0e00000225-1506475638.995008-257981642', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:41:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 18:41:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 18:41:41 INFO - Using env: {'DISPLAY': ':0', 18:41:41 INFO - 'HOME': '/home/cltbld', 18:41:41 INFO - 'LANG': 'en_US.UTF-8', 18:41:41 INFO - 'LANGUAGE': 'en_US:en', 18:41:41 INFO - 'LOGNAME': 'cltbld', 18:41:41 INFO - 'MAIL': '/var/mail/cltbld', 18:41:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:41:41 INFO - 'MOZ_NO_REMOTE': '1', 18:41:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:41:41 INFO - 'NO_EM_RESTART': '1', 18:41:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:41:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:41:41 INFO - 'PWD': '/builds/slave/test', 18:41:41 INFO - 'SHELL': '/bin/bash', 18:41:41 INFO - 'SHLVL': '1', 18:41:41 INFO - 'TERM': 'linux', 18:41:41 INFO - 'TMOUT': '86400', 18:41:41 INFO - 'USER': 'cltbld', 18:41:41 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1506475638.995008-257981642', 18:41:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:41:41 INFO - '_': '/tools/buildbot/bin/python'} 18:41:43 INFO - Ignoring indexes: http://pypi.python.org/simple/ 18:41:43 INFO - Downloading/unpacking pip>=1.5 18:41:43 INFO - Running setup.py egg_info for package pip 18:41:43 INFO - warning: no files found matching 'pip/cacert.pem' 18:41:43 INFO - warning: no files found matching '*.html' under directory 'docs' 18:41:43 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 18:41:43 INFO - no previously-included directories found matching 'docs/_build/_sources' 18:41:43 INFO - Installing collected packages: pip 18:41:43 INFO - Found existing installation: pip 1.1 18:41:43 INFO - Uninstalling pip: 18:41:43 INFO - Successfully uninstalled pip 18:41:43 INFO - Running setup.py install for pip 18:41:43 INFO - warning: no files found matching 'pip/cacert.pem' 18:41:43 INFO - warning: no files found matching '*.html' under directory 'docs' 18:41:43 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 18:41:43 INFO - no previously-included directories found matching 'docs/_build/_sources' 18:41:43 INFO - Installing pip script to /builds/slave/test/build/venv/bin 18:41:43 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 18:41:43 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 18:41:43 INFO - Successfully installed pip 18:41:43 INFO - Cleaning up... 18:41:43 INFO - Return code: 0 18:41:43 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 18:41:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:41:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:41:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:41:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:41:43 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 0x19511f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b19b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cbe9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cbbd60>, '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 0x1cbca60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cbcef0>, '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': 'df17445c3590ff7897617a0e00000225-1506475638.995008-257981642', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:41:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 18:41:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 18:41:43 INFO - Using env: {'DISPLAY': ':0', 18:41:43 INFO - 'HOME': '/home/cltbld', 18:41:43 INFO - 'LANG': 'en_US.UTF-8', 18:41:43 INFO - 'LANGUAGE': 'en_US:en', 18:41:43 INFO - 'LOGNAME': 'cltbld', 18:41:43 INFO - 'MAIL': '/var/mail/cltbld', 18:41:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:41:43 INFO - 'MOZ_NO_REMOTE': '1', 18:41:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:41:43 INFO - 'NO_EM_RESTART': '1', 18:41:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:41:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:41:43 INFO - 'PWD': '/builds/slave/test', 18:41:43 INFO - 'SHELL': '/bin/bash', 18:41:43 INFO - 'SHLVL': '1', 18:41:43 INFO - 'TERM': 'linux', 18:41:43 INFO - 'TMOUT': '86400', 18:41:43 INFO - 'USER': 'cltbld', 18:41:43 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1506475638.995008-257981642', 18:41:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:41:43 INFO - '_': '/tools/buildbot/bin/python'} 18:41:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:41:43 INFO - Downloading/unpacking psutil>=3.1.1 18:41:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:41:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:41:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:41:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:41:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:41:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:41:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:41:44 INFO - Installing collected packages: psutil 18:41:44 INFO - Running setup.py install for psutil 18:41:44 INFO - building 'psutil._psutil_linux' extension 18:41:44 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 18:41:44 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 18:41:44 INFO - building 'psutil._psutil_posix' extension 18:41:44 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 18:41:44 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 18:41:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:41:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:41:45 INFO - Successfully installed psutil 18:41:45 INFO - Cleaning up... 18:41:45 INFO - Return code: 0 18:41:45 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 18:41:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:41:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:41:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:41:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:41:45 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 0x19511f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b19b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cbe9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cbbd60>, '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 0x1cbca60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cbcef0>, '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': 'df17445c3590ff7897617a0e00000225-1506475638.995008-257981642', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:41:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 18:41:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 18:41:45 INFO - Using env: {'DISPLAY': ':0', 18:41:45 INFO - 'HOME': '/home/cltbld', 18:41:45 INFO - 'LANG': 'en_US.UTF-8', 18:41:45 INFO - 'LANGUAGE': 'en_US:en', 18:41:45 INFO - 'LOGNAME': 'cltbld', 18:41:45 INFO - 'MAIL': '/var/mail/cltbld', 18:41:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:41:45 INFO - 'MOZ_NO_REMOTE': '1', 18:41:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:41:45 INFO - 'NO_EM_RESTART': '1', 18:41:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:41:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:41:45 INFO - 'PWD': '/builds/slave/test', 18:41:45 INFO - 'SHELL': '/bin/bash', 18:41:45 INFO - 'SHLVL': '1', 18:41:45 INFO - 'TERM': 'linux', 18:41:45 INFO - 'TMOUT': '86400', 18:41:45 INFO - 'USER': 'cltbld', 18:41:45 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1506475638.995008-257981642', 18:41:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:41:45 INFO - '_': '/tools/buildbot/bin/python'} 18:41:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:41:45 INFO - Downloading/unpacking mozsystemmonitor==0.3 18:41:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:41:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:41:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:41:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:41:46 INFO - Downloading mozsystemmonitor-0.3.tar.gz 18:41:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:41:46 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 18:41:46 INFO - Installing collected packages: mozsystemmonitor 18:41:46 INFO - Running setup.py install for mozsystemmonitor 18:41:46 INFO - Successfully installed mozsystemmonitor 18:41:46 INFO - Cleaning up... 18:41:47 INFO - Return code: 0 18:41:47 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 18:41:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:41:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:41:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:41:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:41:47 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 0x19511f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b19b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cbe9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cbbd60>, '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 0x1cbca60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cbcef0>, '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': 'df17445c3590ff7897617a0e00000225-1506475638.995008-257981642', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:41:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 18:41:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 18:41:47 INFO - Using env: {'DISPLAY': ':0', 18:41:47 INFO - 'HOME': '/home/cltbld', 18:41:47 INFO - 'LANG': 'en_US.UTF-8', 18:41:47 INFO - 'LANGUAGE': 'en_US:en', 18:41:47 INFO - 'LOGNAME': 'cltbld', 18:41:47 INFO - 'MAIL': '/var/mail/cltbld', 18:41:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:41:47 INFO - 'MOZ_NO_REMOTE': '1', 18:41:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:41:47 INFO - 'NO_EM_RESTART': '1', 18:41:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:41:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:41:47 INFO - 'PWD': '/builds/slave/test', 18:41:47 INFO - 'SHELL': '/bin/bash', 18:41:47 INFO - 'SHLVL': '1', 18:41:47 INFO - 'TERM': 'linux', 18:41:47 INFO - 'TMOUT': '86400', 18:41:47 INFO - 'USER': 'cltbld', 18:41:47 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1506475638.995008-257981642', 18:41:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:41:47 INFO - '_': '/tools/buildbot/bin/python'} 18:41:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:41:47 INFO - Downloading/unpacking jsonschema==2.5.1 18:41:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:41:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:41:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:41:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:41:48 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:41:48 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 18:41:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:41:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:41:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:41:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:41:49 INFO - Downloading functools32-3.2.3-2.tar.gz 18:41:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:41:49 INFO - warning: no files found matching '*.txt' 18:41:49 INFO - no previously-included directories found matching 'build' 18:41:49 INFO - no previously-included directories found matching 'dist' 18:41:49 INFO - no previously-included directories found matching '.git*' 18:41:49 INFO - Installing collected packages: jsonschema, functools32 18:41:49 INFO - Running setup.py install for functools32 18:41:49 INFO - warning: no files found matching '*.txt' 18:41:49 INFO - no previously-included directories found matching 'build' 18:41:49 INFO - no previously-included directories found matching 'dist' 18:41:49 INFO - no previously-included directories found matching '.git*' 18:41:49 INFO - Successfully installed jsonschema functools32 18:41:49 INFO - Cleaning up... 18:41:49 INFO - Return code: 0 18:41:49 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 18:41:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:41:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:41:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:41:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:41:49 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 0x19511f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b19b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cbe9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cbbd60>, '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 0x1cbca60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cbcef0>, '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': 'df17445c3590ff7897617a0e00000225-1506475638.995008-257981642', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:41:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 18:41:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 18:41:49 INFO - Using env: {'DISPLAY': ':0', 18:41:49 INFO - 'HOME': '/home/cltbld', 18:41:49 INFO - 'LANG': 'en_US.UTF-8', 18:41:49 INFO - 'LANGUAGE': 'en_US:en', 18:41:49 INFO - 'LOGNAME': 'cltbld', 18:41:49 INFO - 'MAIL': '/var/mail/cltbld', 18:41:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:41:49 INFO - 'MOZ_NO_REMOTE': '1', 18:41:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:41:49 INFO - 'NO_EM_RESTART': '1', 18:41:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:41:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:41:49 INFO - 'PWD': '/builds/slave/test', 18:41:49 INFO - 'SHELL': '/bin/bash', 18:41:49 INFO - 'SHLVL': '1', 18:41:49 INFO - 'TERM': 'linux', 18:41:49 INFO - 'TMOUT': '86400', 18:41:49 INFO - 'USER': 'cltbld', 18:41:49 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1506475638.995008-257981642', 18:41:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:41:49 INFO - '_': '/tools/buildbot/bin/python'} 18:41:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:41:50 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 18:41:50 INFO - Cleaning up... 18:41:50 INFO - Return code: 0 18:41:50 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:41:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:41:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:41:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:41:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:41:50 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 0x19511f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b19b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cbe9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cbbd60>, '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 0x1cbca60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cbcef0>, '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': 'df17445c3590ff7897617a0e00000225-1506475638.995008-257981642', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:41:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 18:41:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 18:41:50 INFO - Using env: {'DISPLAY': ':0', 18:41:50 INFO - 'HOME': '/home/cltbld', 18:41:50 INFO - 'LANG': 'en_US.UTF-8', 18:41:50 INFO - 'LANGUAGE': 'en_US:en', 18:41:50 INFO - 'LOGNAME': 'cltbld', 18:41:50 INFO - 'MAIL': '/var/mail/cltbld', 18:41:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:41:50 INFO - 'MOZ_NO_REMOTE': '1', 18:41:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:41:50 INFO - 'NO_EM_RESTART': '1', 18:41:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:41:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:41:50 INFO - 'PWD': '/builds/slave/test', 18:41:50 INFO - 'SHELL': '/bin/bash', 18:41:50 INFO - 'SHLVL': '1', 18:41:50 INFO - 'TERM': 'linux', 18:41:50 INFO - 'TMOUT': '86400', 18:41:50 INFO - 'USER': 'cltbld', 18:41:50 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1506475638.995008-257981642', 18:41:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:41:50 INFO - '_': '/tools/buildbot/bin/python'} 18:41:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:41:50 INFO - Downloading/unpacking blobuploader==1.2.4 18:41:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:41:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:41:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:41:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:41:52 INFO - Downloading blobuploader-1.2.4.tar.gz 18:41:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:41:52 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:41:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:41:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:41:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:41:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:41:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:41:52 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:41:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:41:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:41:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:41:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:41:52 INFO - Downloading docopt-0.6.1.tar.gz 18:41:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:41:52 INFO - Installing collected packages: blobuploader, requests, docopt 18:41:52 INFO - Running setup.py install for blobuploader 18:41:52 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:41:52 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:41:52 INFO - Running setup.py install for requests 18:41:53 INFO - Running setup.py install for docopt 18:41:54 INFO - Successfully installed blobuploader requests docopt 18:41:54 INFO - Cleaning up... 18:41:54 INFO - Return code: 0 18:41:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:41:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:41:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:41:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:41:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:41:54 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 0x19511f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b19b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cbe9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cbbd60>, '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 0x1cbca60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cbcef0>, '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': 'df17445c3590ff7897617a0e00000225-1506475638.995008-257981642', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:41:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 18:41:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 18:41:54 INFO - Using env: {'DISPLAY': ':0', 18:41:54 INFO - 'HOME': '/home/cltbld', 18:41:54 INFO - 'LANG': 'en_US.UTF-8', 18:41:54 INFO - 'LANGUAGE': 'en_US:en', 18:41:54 INFO - 'LOGNAME': 'cltbld', 18:41:54 INFO - 'MAIL': '/var/mail/cltbld', 18:41:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:41:54 INFO - 'MOZ_NO_REMOTE': '1', 18:41:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:41:54 INFO - 'NO_EM_RESTART': '1', 18:41:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:41:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:41:54 INFO - 'PWD': '/builds/slave/test', 18:41:54 INFO - 'SHELL': '/bin/bash', 18:41:54 INFO - 'SHLVL': '1', 18:41:54 INFO - 'TERM': 'linux', 18:41:54 INFO - 'TMOUT': '86400', 18:41:54 INFO - 'USER': 'cltbld', 18:41:54 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1506475638.995008-257981642', 18:41:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:41:54 INFO - '_': '/tools/buildbot/bin/python'} 18:41:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:41:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:41:55 INFO - Running setup.py (path:/tmp/pip-fxtzd4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:41:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:41:55 INFO - Running setup.py (path:/tmp/pip-VgJaHb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:41:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:41:55 INFO - Running setup.py (path:/tmp/pip-Vyo0bC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:41:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:41:56 INFO - Running setup.py (path:/tmp/pip-TBPar4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:41:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:41:56 INFO - Running setup.py (path:/tmp/pip-VbZNHi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:41:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:41:56 INFO - Running setup.py (path:/tmp/pip-bSaNoH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:41:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:41:56 INFO - Running setup.py (path:/tmp/pip-2giL3Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:41:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:41:56 INFO - Running setup.py (path:/tmp/pip-RC_9ki-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:41:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:41:56 INFO - Running setup.py (path:/tmp/pip-LBIg91-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:41:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:41:56 INFO - Running setup.py (path:/tmp/pip-oBV6cI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:41:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:41:56 INFO - Running setup.py (path:/tmp/pip-nCRlsx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:41:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:41:56 INFO - Running setup.py (path:/tmp/pip-NbN_tG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:41:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:41:56 INFO - Running setup.py (path:/tmp/pip-PeiHMS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:41:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:41:56 INFO - Running setup.py (path:/tmp/pip-eI6NGE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:41:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:41:56 INFO - Running setup.py (path:/tmp/pip-53pdjl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:41:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:41:56 INFO - Running setup.py (path:/tmp/pip-wI6YsG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:41:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:41:56 INFO - Running setup.py (path:/tmp/pip-uOcAcb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:41:57 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:41:57 INFO - Running setup.py install for manifestparser 18:41:57 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:41:57 INFO - Running setup.py install for mozcrash 18:41:57 INFO - Running setup.py install for mozdebug 18:41:57 INFO - Running setup.py install for mozdevice 18:41:57 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:41:57 INFO - Running setup.py install for mozfile 18:41:57 INFO - Running setup.py install for mozhttpd 18:41:57 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:41:57 INFO - Running setup.py install for mozinfo 18:41:57 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:41:57 INFO - Running setup.py install for mozInstall 18:41:57 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:41:57 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:41:57 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:41:57 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:41:57 INFO - Running setup.py install for mozleak 18:41:57 INFO - Running setup.py install for mozlog 18:41:58 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:41:58 INFO - Running setup.py install for moznetwork 18:41:58 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:41:58 INFO - Running setup.py install for mozprocess 18:41:58 INFO - Running setup.py install for mozprofile 18:41:58 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:41:58 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:41:58 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:41:58 INFO - Running setup.py install for mozrunner 18:41:58 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:41:58 INFO - Running setup.py install for mozscreenshot 18:41:58 INFO - Running setup.py install for moztest 18:41:58 INFO - Running setup.py install for mozversion 18:41:58 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:41:58 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:41:58 INFO - Cleaning up... 18:41:58 INFO - Return code: 0 18:41:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:41: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')]} 18:41:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:41: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')]} 18:41:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:41:58 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 0x19511f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b19b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cbe9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cbbd60>, '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 0x1cbca60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cbcef0>, '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': 'df17445c3590ff7897617a0e00000225-1506475638.995008-257981642', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:41:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 18:41:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 18:41:58 INFO - Using env: {'DISPLAY': ':0', 18:41:58 INFO - 'HOME': '/home/cltbld', 18:41:58 INFO - 'LANG': 'en_US.UTF-8', 18:41:58 INFO - 'LANGUAGE': 'en_US:en', 18:41:58 INFO - 'LOGNAME': 'cltbld', 18:41:58 INFO - 'MAIL': '/var/mail/cltbld', 18:41:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:41:58 INFO - 'MOZ_NO_REMOTE': '1', 18:41:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:41:58 INFO - 'NO_EM_RESTART': '1', 18:41:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:41:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:41:58 INFO - 'PWD': '/builds/slave/test', 18:41:58 INFO - 'SHELL': '/bin/bash', 18:41:58 INFO - 'SHLVL': '1', 18:41:58 INFO - 'TERM': 'linux', 18:41:58 INFO - 'TMOUT': '86400', 18:41:58 INFO - 'USER': 'cltbld', 18:41:58 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1506475638.995008-257981642', 18:41:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:41:58 INFO - '_': '/tools/buildbot/bin/python'} 18:41:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:41:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:41:59 INFO - Running setup.py (path:/tmp/pip-IY6v68-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:41:59 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 18:41:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:41:59 INFO - Running setup.py (path:/tmp/pip-WAkJno-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:41:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 18:41:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:41:59 INFO - Running setup.py (path:/tmp/pip-NJbDSH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:41:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 18:41:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:41:59 INFO - Running setup.py (path:/tmp/pip-JZI06N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:41:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.51 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 18:41:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:41:59 INFO - Running setup.py (path:/tmp/pip-LGag95-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:41:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 18:41:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:41:59 INFO - Running setup.py (path:/tmp/pip-Jf31b5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:41:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 18:41:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:41:59 INFO - Running setup.py (path:/tmp/pip-tPoD2p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:41:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.10 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 18:41:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:41:59 INFO - Running setup.py (path:/tmp/pip-IcJ6RC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:41:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.13 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 18:41:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:41:59 INFO - Running setup.py (path:/tmp/pip-poioJL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:41:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 18:41:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:41:59 INFO - Running setup.py (path:/tmp/pip-juKyoH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:41:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.5 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:41:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:41:59 INFO - Running setup.py (path:/tmp/pip-UCAZfC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:41:59 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 18:41:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:41:59 INFO - Running setup.py (path:/tmp/pip-yaKZzn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:41:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 18:41:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:41:59 INFO - Running setup.py (path:/tmp/pip-uBndQF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:41:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 18:41:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:41:59 INFO - Running setup.py (path:/tmp/pip-kAj4PJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:42:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 18:42:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:42:00 INFO - Running setup.py (path:/tmp/pip-zzw9Ic-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:42:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 18:42:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:42:00 INFO - Running setup.py (path:/tmp/pip-LDMa5a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:42:00 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 18:42:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:42:00 INFO - Running setup.py (path:/tmp/pip-FHq7DM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:42:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 18:42:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 18:42:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 18:42:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 18:42:00 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 18:42:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 18:42:00 INFO - Requirement already satisfied (use --upgrade to upgrade): requests in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozInstall==1.13->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 18:42:00 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:42:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:42:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:42:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:42:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:42:01 INFO - Downloading blessings-1.6.tar.gz 18:42:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:42:01 INFO - Installing collected packages: blessings 18:42:01 INFO - Running setup.py install for blessings 18:42:01 INFO - Successfully installed blessings 18:42:01 INFO - Cleaning up... 18:42:01 INFO - Return code: 0 18:42:01 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:42:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:42:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:42:01 INFO - Reading from file tmpfile_stdout 18:42:01 INFO - Current package versions: 18:42:01 INFO - argparse == 1.2.1 18:42:01 INFO - blessings == 1.6 18:42:01 INFO - blobuploader == 1.2.4 18:42:01 INFO - docopt == 0.6.1 18:42:01 INFO - functools32 == 3.2.3-2 18:42:01 INFO - jsonschema == 2.5.1 18:42:01 INFO - manifestparser == 1.1 18:42:01 INFO - mozInstall == 1.13 18:42:01 INFO - mozcrash == 1.0 18:42:01 INFO - mozdebug == 0.1 18:42:01 INFO - mozdevice == 0.51 18:42:01 INFO - mozfile == 1.2 18:42:01 INFO - mozhttpd == 0.7 18:42:01 INFO - mozinfo == 0.10 18:42:01 INFO - mozleak == 0.1 18:42:01 INFO - mozlog == 3.5 18:42:01 INFO - moznetwork == 0.27 18:42:01 INFO - mozprocess == 0.25 18:42:01 INFO - mozprofile == 0.28 18:42:01 INFO - mozrunner == 6.13 18:42:01 INFO - mozscreenshot == 0.1 18:42:01 INFO - mozsystemmonitor == 0.3 18:42:01 INFO - moztest == 0.8 18:42:01 INFO - mozversion == 1.4 18:42:01 INFO - psutil == 3.1.1 18:42:01 INFO - requests == 1.2.3 18:42:01 INFO - wsgiref == 0.1.2 18:42:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:42:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:42:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:42:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:42:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:42:01 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 0x19511f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b19b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cbe9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cbbd60>, '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 0x1cbca60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cbcef0>, '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': 'df17445c3590ff7897617a0e00000225-1506475638.995008-257981642', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:42:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 18:42:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 18:42:01 INFO - Using env: {'DISPLAY': ':0', 18:42:01 INFO - 'HOME': '/home/cltbld', 18:42:01 INFO - 'LANG': 'en_US.UTF-8', 18:42:01 INFO - 'LANGUAGE': 'en_US:en', 18:42:01 INFO - 'LOGNAME': 'cltbld', 18:42:01 INFO - 'MAIL': '/var/mail/cltbld', 18:42:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:42:01 INFO - 'MOZ_NO_REMOTE': '1', 18:42:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:42:01 INFO - 'NO_EM_RESTART': '1', 18:42:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:42:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:42:01 INFO - 'PWD': '/builds/slave/test', 18:42:01 INFO - 'SHELL': '/bin/bash', 18:42:01 INFO - 'SHLVL': '1', 18:42:01 INFO - 'TERM': 'linux', 18:42:01 INFO - 'TMOUT': '86400', 18:42:01 INFO - 'USER': 'cltbld', 18:42:01 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1506475638.995008-257981642', 18:42:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:42:01 INFO - '_': '/tools/buildbot/bin/python'} 18:42:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:42:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 18:42:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 18:42:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 18:42:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 18:42:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 18:42:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 18:42:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 18:42:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 18:42:02 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 18:42:02 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 18:42:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:42:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:42:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:42:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:42:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 18:42:03 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 18:42:03 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 18:42:03 INFO - Installing collected packages: simplejson 18:42:03 INFO - Running setup.py install for simplejson 18:42:03 INFO - building 'simplejson._speedups' extension 18:42:03 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c simplejson/_speedups.c -o build/temp.linux-x86_64-2.7/simplejson/_speedups.o 18:42:04 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/simplejson/_speedups.o -o build/lib.linux-x86_64-2.7/simplejson/_speedups.so 18:42:04 INFO - Successfully installed simplejson 18:42:04 INFO - Cleaning up... 18:42:04 INFO - Return code: 0 18:42:04 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:42:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:42:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:42:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:42:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:42:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19511f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b19b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cbe9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cbbd60>, '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 0x1cbca60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cbcef0>, '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': 'df17445c3590ff7897617a0e00000225-1506475638.995008-257981642', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:42:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 18:42:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 18:42:04 INFO - Using env: {'DISPLAY': ':0', 18:42:04 INFO - 'HOME': '/home/cltbld', 18:42:04 INFO - 'LANG': 'en_US.UTF-8', 18:42:04 INFO - 'LANGUAGE': 'en_US:en', 18:42:04 INFO - 'LOGNAME': 'cltbld', 18:42:04 INFO - 'MAIL': '/var/mail/cltbld', 18:42:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:42:04 INFO - 'MOZ_NO_REMOTE': '1', 18:42:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:42:04 INFO - 'NO_EM_RESTART': '1', 18:42:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:42:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:42:04 INFO - 'PWD': '/builds/slave/test', 18:42:04 INFO - 'SHELL': '/bin/bash', 18:42:04 INFO - 'SHLVL': '1', 18:42:04 INFO - 'TERM': 'linux', 18:42:04 INFO - 'TMOUT': '86400', 18:42:04 INFO - 'USER': 'cltbld', 18:42:04 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1506475638.995008-257981642', 18:42:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:42:04 INFO - '_': '/tools/buildbot/bin/python'} 18:42:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:42:04 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 18:42:04 INFO - Cleaning up... 18:42:04 INFO - Return code: 0 18:42:04 INFO - Running post-action listener: _resource_record_post_action 18:42:04 INFO - Running post-action listener: _start_resource_monitoring 18:42:04 INFO - Starting resource monitoring. 18:42:04 INFO - [mozharness: 2017-09-27 01:42:04.519954Z] Finished create-virtualenv step (success) 18:42:04 INFO - [mozharness: 2017-09-27 01:42:04.520478Z] Running install step. 18:42:04 INFO - Running pre-action listener: _resource_record_pre_action 18:42:04 INFO - Running main action method: install 18:42:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:42:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:42:04 INFO - Reading from file tmpfile_stdout 18:42:04 INFO - Detecting whether we're running mozinstall >=1.0... 18:42:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:42:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:42:04 INFO - Reading from file tmpfile_stdout 18:42:04 INFO - Output received: 18:42:04 INFO - Usage: mozinstall [options] installer 18:42:04 INFO - Options: 18:42:04 INFO - -h, --help show this help message and exit 18:42:04 INFO - -d DEST, --destination=DEST 18:42:04 INFO - Directory to install application into. [default: 18:42:04 INFO - "/builds/slave/test"] 18:42:04 INFO - --app=APP Application being installed. [default: firefox] 18:42:04 INFO - mkdir: /builds/slave/test/build/application 18:42:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 18:42:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 18:42:22 INFO - Reading from file tmpfile_stdout 18:42:22 INFO - Output received: 18:42:22 INFO - /builds/slave/test/build/application/firefox/firefox 18:42:22 INFO - Running post-action listener: _resource_record_post_action 18:42:22 INFO - [mozharness: 2017-09-27 01:42:22.510637Z] Finished install step (success) 18:42:22 INFO - [mozharness: 2017-09-27 01:42:22.510889Z] Running setup-mitmproxy step. 18:42:22 INFO - Running pre-action listener: _resource_record_pre_action 18:42:22 INFO - Running main action method: setup_mitmproxy 18:42:22 INFO - Skipping: mitmproxy is not required 18:42:22 INFO - Running post-action listener: _resource_record_post_action 18:42:22 INFO - [mozharness: 2017-09-27 01:42:22.512017Z] Finished setup-mitmproxy step (success) 18:42:22 INFO - [mozharness: 2017-09-27 01:42:22.512235Z] Running run-tests step. 18:42:22 INFO - Running pre-action listener: _resource_record_pre_action 18:42:22 INFO - Running pre-action listener: _set_gcov_prefix 18:42:22 INFO - Running main action method: run_tests 18:42:22 WARNING - Try message not found. 18:42:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:42:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:42:22 INFO - Python 2.7.3 18:42:22 INFO - Return code: 0 18:42:22 INFO - grabbing minidump binary from tooltool 18:42:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:42:22 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--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 0x1cbbd60>, '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 0x1cbca60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cbcef0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:42:22 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 18:42:22 INFO - Copy/paste: /tools/tooltool.py --url https://tooltool.mozilla-releng.net/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 18:42:22 INFO - Calling ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 18:42:22 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:42:22 INFO - Return code: 0 18:42:22 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 18:42:22 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:42:22 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:42:22 INFO - ENV: RUST_BACKTRACE is now full 18:42:22 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 18:42:22 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:42:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-stylo-disabled-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ViBZ0mWEQlOae9cmg2YqOQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-021', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log'] in /builds/slave/test/build 18:42:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-stylo-disabled-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ViBZ0mWEQlOae9cmg2YqOQ/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-021 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log 18:42:22 INFO - Using env: {'DISPLAY': ':0', 18:42:22 INFO - 'HOME': '/home/cltbld', 18:42:22 INFO - 'LANG': 'en_US.UTF-8', 18:42:22 INFO - 'LANGUAGE': 'en_US:en', 18:42:22 INFO - 'LOGNAME': 'cltbld', 18:42:22 INFO - 'MAIL': '/var/mail/cltbld', 18:42:22 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:42:22 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 18:42:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:42:22 INFO - 'MOZ_NO_REMOTE': '1', 18:42:22 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:42:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:42:22 INFO - 'NO_EM_RESTART': '1', 18:42:22 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:42:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:42:22 INFO - 'PWD': '/builds/slave/test', 18:42:22 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:42:22 INFO - 'RUST_BACKTRACE': 'full', 18:42:22 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 18:42:22 INFO - 'SHELL': '/bin/bash', 18:42:22 INFO - 'SHLVL': '1', 18:42:22 INFO - 'TERM': 'linux', 18:42:22 INFO - 'TMOUT': '86400', 18:42:22 INFO - 'USER': 'cltbld', 18:42:22 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1506475638.995008-257981642', 18:42:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:42:22 INFO - '_': '/tools/buildbot/bin/python'} 18:42:22 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-stylo-disabled-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ViBZ0mWEQlOae9cmg2YqOQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-021', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log'] with output_timeout 3600 18:42:22 INFO - mozversion application_buildid: 20170927001127 18:42:22 INFO - mozversion application_changeset: 70158e4e215d784d1391db5e517b18727f4b3683 18:42:22 INFO - mozversion application_display_name: Nightly 18:42:22 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:42:22 INFO - mozversion application_name: Firefox 18:42:22 INFO - mozversion application_remotingname: firefox 18:42:22 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 18:42:22 INFO - mozversion application_vendor: Mozilla 18:42:22 INFO - mozversion application_version: 58.0a1 18:42:22 INFO - mozversion platform_buildid: 20170927001127 18:42:22 INFO - mozversion platform_changeset: 70158e4e215d784d1391db5e517b18727f4b3683 18:42:22 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 18:42:22 INFO - mozversion platform_version: 58.0a1 18:42:22 INFO - using testdate: 1506476542 18:42:22 INFO - actual date: 1506476542 18:42:22 INFO - starting webserver on 'localhost:40127' 18:42:22 INFO - SUITE-START | Running 2 tests 18:42:22 INFO - TEST-START | dromaeo_css 18:42:22 INFO - Initialising browser for dromaeo_css test... 18:42:22 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:40127/getInfo.html -profile /tmp/tmpDl4POl/profile 18:42:22 INFO - TEST-INFO | started process 8100 (/builds/slave/test/build/application/firefox/firefox http://localhost:40127/getInfo.html) 18:42:28 INFO - TEST-INFO | 8100: exit 0 18:42:28 INFO - Browser initialized. 18:42:28 INFO - Running cycle 1/1 for dromaeo_css test... 18:42:28 INFO - Using env: {'DISPLAY': ':0', 18:42:28 INFO - 'HOME': '/home/cltbld', 18:42:28 INFO - 'JSGC_DISABLE_POISONING': '1', 18:42:28 INFO - 'LANG': 'en_US.UTF-8', 18:42:28 INFO - 'LANGUAGE': 'en_US:en', 18:42:28 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 18:42:28 INFO - 'LOGNAME': 'cltbld', 18:42:28 INFO - 'MAIL': '/var/mail/cltbld', 18:42:28 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:42:28 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 18:42:28 INFO - 'MOZ_CRASHREPORTER': '1', 18:42:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:42:28 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 18:42:28 INFO - 'MOZ_NO_REMOTE': '1', 18:42:28 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:42:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:42:28 INFO - 'NO_EM_RESTART': '1', 18:42:28 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:42:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:42:28 INFO - 'PWD': '/builds/slave/test', 18:42:28 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:42:28 INFO - 'RUST_BACKTRACE': 'full', 18:42:28 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 18:42:28 INFO - 'SHELL': '/bin/bash', 18:42:28 INFO - 'SHLVL': '1', 18:42:28 INFO - 'STYLO_FORCE_DISABLED': '1', 18:42:28 INFO - 'TERM': 'linux', 18:42:28 INFO - 'TMOUT': '86400', 18:42:28 INFO - 'USER': 'cltbld', 18:42:28 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1506475638.995008-257981642', 18:42:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:42:28 INFO - '_': '/tools/buildbot/bin/python'} 18:42:28 INFO - TEST-INFO | started process 8337 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDl4POl/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 18:42:29 INFO - PID 8337 | 18:42:29 INFO - PID 8337 | (/builds/slave/test/build/application/firefox/firefox:8386): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 18:42:29 INFO - PID 8337 | 18:42:39 INFO - PID 8337 | RSS: Main: 144588800 18:42:39 INFO - PID 8337 | 18:45:37 INFO - PID 8337 | Cycle 1(1): loaded http://localhost:40127/tests/dromaeo/cssquery-dojo.html (next: http://localhost:40127/tests/dromaeo/cssquery-ext.html) 18:45:38 INFO - PID 8337 | RSS: Main: 146468864 18:45:38 INFO - PID 8337 | 18:48:39 INFO - PID 8337 | Cycle 1(1): loaded http://localhost:40127/tests/dromaeo/cssquery-ext.html (next: http://localhost:40127/tests/dromaeo/cssquery-jquery.html) 18:48:40 INFO - PID 8337 | RSS: Main: 146149376 18:48:40 INFO - PID 8337 | 18:51:42 INFO - PID 8337 | Cycle 1(1): loaded http://localhost:40127/tests/dromaeo/cssquery-jquery.html (next: http://localhost:40127/tests/dromaeo/cssquery-mootools.html) 18:51:42 INFO - PID 8337 | RSS: Main: 148234240 18:51:42 INFO - PID 8337 | 18:54:44 INFO - PID 8337 | Cycle 1(1): loaded http://localhost:40127/tests/dromaeo/cssquery-mootools.html (next: http://localhost:40127/tests/dromaeo/cssquery-prototype.html) 18:54:44 INFO - PID 8337 | RSS: Main: 146530304 18:54:44 INFO - PID 8337 | 18:57:47 INFO - PID 8337 | Cycle 1(1): loaded http://localhost:40127/tests/dromaeo/cssquery-prototype.html (next: http://localhost:40127/tests/dromaeo/cssquery-yui.html) 18:57:48 INFO - PID 8337 | RSS: Main: 147927040 18:57:48 INFO - PID 8337 | 19:00:49 INFO - PID 8337 | Cycle 1(1): loaded http://localhost:40127/tests/dromaeo/cssquery-yui.html (next: http://localhost:40127/tests/dromaeo/cssquery-dojo.html) 19:00:50 INFO - PID 8337 | RSS: Main: 150577152 19:00:50 INFO - PID 8337 | 19:00:50 INFO - PID 8337 | __start_tp_report 19:00:50 INFO - PID 8337 | _x_x_mozilla_page_load 19:00:50 INFO - PID 8337 | _x_x_mozilla_page_load_details 19:00:50 INFO - PID 8337 | |i|pagename|runs| 19:00:50 INFO - PID 8337 | |0;dojo.html;3850.653441190293;3871.612838716129;3881.1461478474735;3919.0202449387652;3925.2934471795065;6177.876442471148;6192.41172088652;6209.441150296472;6222.346653601369;6275.6548389838545;6253.812385628427;6353.174087368647;6354.3963323484195;6381.680915954195;6396.648184349859;780.9027105544086;5432.483914028161;5580.246666699984;5643.379228284885;5700.828975130753;5539.224508568804;5550.5282051025715;5577.8047768328115;5590.413006634306;5603;5583.5254003409755;5597.720113994284;5623.156526521055;5625.943740562603;5628.831135065934;5589.608727389084;5653.519450846683;5655.830325090213;5660.971695141539;5665.065264231397;5560.944390556083;5608.4391560844;5647.37878833328;5658.660480371191;5677.233573467571;6002.669853158074;6104.572679912408;6210.068489726532;6299.937000630027;6312.842178945517;6578.572392794453;6579.638119903403;6580.670966451707;6585.901211481783;6592.1100651411925;6594.142761440982;6667.766628167991;6674.899876501856;6683;6693.062971184038;6348.809535713982;6359.236891572995;6379.872402551923;6381.425671689523;6385.936140638581;6887.449004079662;6955.756548520879;6957.095577574883;7038.894416583756;7042.225355210922;6557.442617377576;6670.966645166744;6677.966610166918;6718.798436046926;6787.592744435349;6744.696488658022;6752.493562982796;6774.390304872585;6777.288384719632;6788;6718.328167183243;6801.557898736665;6823.38589526945;6837.076994605764;6845.315468453115;6755.695993680296;6756.020377045399;6789.117414736152;6862;6864.24493305736;4927.7536123193695;4961.6526843121355;5006.048850718352;5049.823256186016;5050.242463630485;4478.171538265431;4495.707778994355;4519.118771839526;4520.841770538015;4560.0195957868555;6200.782972596027;6360.491160707133;6368.29948705642;6374.330695277022;6385.936140638627;6754.864902701918;6767.120274364301;6791.966040169867;6855;6859.07402500656;6166.198394208814;6269.905951410732;6271;6280.685965701697;6286.5599408041;5459.454054594509;5463.098588732894;5522.088855338824;5525.392206857243;5560.777568897199;6986.965065174743;7089.042979197846;7160.964195178991;7172.103487064117;7191.352778249982;6579.769708060195;6720.966395168189;6737.73049078051;6816.113905192294;6865.313468653295;6956.16526016861;6959.095317608679;6961.547499412724;6970.756023539152;6973.721051157897;6613.239477459962;6621.33786621334;6626.53614246998;6689.732410703517;6772.898406524005;6682.46540276767;6801.081853949653;6894.207166175754;6901.516893817385;6903.551269167488;6536.444402225674;6538.280789113289;6545.050967609765;6633.767818126343;6634.237062737847;6304.5586808922935;6420.967895160495;6425.5502114851515;6426.389492998158;6426.614403135827;6180.845478863064;6336.9049464259;6367.204099487564;6412.775552855627;6448.065030570635;6534.1178940844275;6635.767748128792;6694.698738556679;6729.1252137221845;6750.189977202767;6299.181106456132;6414.583052101599;6433.035044743138;6433.5496515243485;6540.117084193573 19:00:50 INFO - PID 8337 | |1;ext.html;757.5454727163701;777.6694904665512;777.7122464688066;777.8133248020473;780.2041917244412;43837.78081109594;44662.33006504905;44697.329540056846;44815;44849.32726009112;40709;40723.796381018125;40904.79547602265;41060.794696026554;41124.58875411245;7296.781096567098;7320.2313757055545;7382.889256661128;7385.187629360766;7390.704371825121;7332.413406927433;7337.0828646419195;7370.668319925616;7403.111626604788;7412;8369.874451883195;8498.702545410912;8506.447080939719;8510.829783404328;8515.361347898901;8362.8327433451;8380.329573634124;8383.62273697682;8444.746657600252;8451.492910425393;8144.796380090486;8257.917420825775;8280.5859707015;8282.8343433131;8286.047104582989;40485.79757101196;40851;40971.59028409737;41082.79458602718;41162.38256426156;3691.7046636269033;3748.662620364153;3748.737588368815;3750.1562148516637;3752.2307926874923;33318.16704582405;33639.159021024425;33799.6620033799;33819.83090084558;33849.32301353959;5468.9726551367385;5487.506124448819;5492.340919089735;5504.091824848895;5555.194496797982;221413;222397;222530;223507;223799;48267.275990860166;48664.513354866;53518;53935.73032134893;54798;56322;56372.71813640906;56578.717106415024;56739.43260567424;56750.7162464185;16105.27526261321;16134.193290335435;16223.269952851913;16228.51314460568;16282.51152465428;13107.868921310665;13126.474941002443;13191.208527488381;13207.07550471477;13207.141535800141;14946.70106597862;15042.32309546073;15075.54773356801;15179.696406071816;15233.23833808305;6023.668698221552;6032.698365081728;6087.269527656709;6237.500999919996;6258.906116408258;1092.6230450494568;1093.1145771924766;1111.6831702964616;1115.0800589513683;1125.4597793059377;24931.750682493304;25181.370465738135;25226.495470090864;25419.110331138323;25482.617760733603;1186.1400484648734;1201.7236035711835;1205.2166092040245;1207.8792120788028;1210.5702475621204;13216.669583260495;13531.932340338235;13535.796963045563;13554;13798.517051903336;286466;290061;290238;290972;291109;59165.70417147973;59645.40354596485;59963;59971.40028599746;60173;1469.463645769308;1507.186119495482;1523.4363285584404;1540.9306581203873;1553.4873491747696;24864.50270994606;24948.625770613817;25011.749882500942;25067.49865002726;25183.496330073664;40989.38515922204;41085.972850677776;41156.79421602993;41158.794206028775;41228.38157427701;223647;224432;225665;225762;225927;36665.26669466649;39727.80136099301;39906;40207.59792402039;40367.79816100901;52018.47981520136;53071.20393194028;53150.2027469596;53409.198862017874;53743.193852093034;38308;38469.42295865508;38558;38760;38764.61235387723;37527.81236093802;37820.810895945346;37941.62058379492;37979.62020379761;38404.23191536209;43705;44332.556674432846;45170;45215.32177017413;45413.31880021736;36650.45024324691;36653.81673091617;36676.63323366732;36688.63311366852;36760;26483.73516264813;26973.055943041898;27238.5914211283;27271.454570908074;27689.169324920284 19:00:50 INFO - PID 8337 | |2;jquery.html;604.9667268300244;625.1279465146124;626.4236902050113;640.839790052487;644.3492073006264;22632.660510092363;23566.52866942662;24063.75936240637;24146.396340091484;24156.75843241567;24476.14333498328;25829;25841.353966150855;25850.741492585068;25857.48285034298;6446.774362897299;6590.835229119262;6599.307072757363;6600.6699665016795;6605.768798092067;6411.583247088947;6437.9678101609425;6613.801585952405;6645.4019138277545;6651.8337041574105;6554.9344506555035;6595.241547222059;6611.702473388685;6614.900776488333;6615.669216539178;6397.904031439532;6593.571417857848;6601.2078550574;6602.636854972975;6620.602763834186;6191.752329906798;6192.164057852222;6221.720022598994;6227.439530442282;6240.968795156041;29699.10902672923;30324.393512129634;30337.938172163867;30345.63444644974;30360;2244.9663255051187;2277.1802151225547;2280.201929324723;2280.749117597063;2283.5547068321684;19838.70241946372;20462.897685511627;20532.38402847917;20689.482762930897;20706.79293207064;2469.9012039518398;2495.9376015599573;2548.24826676131;2576.2013775729583;2583.5220484210295;136313;142584.287078565;154652;160765.19617401954;161208;15073.177540277435;15600.92199538995;16017.439389621308;16628.418005369753;16960.74558881618;26039.73960260411;26106.216813495244;26106.216813495626;26172.476550469266;26201.379862013648;10259.332573530935;10300.948495257475;10404;10657.360558366523;10723.731906702395;9532.142107210384;9583.904160958302;9645.37305075168;9648.614055437703;9760.414375137372;9628.229741620653;9816.901830981742;9857.507124643738;9878.753031174278;9893.307468477282;2674.371522692166;2713.1046754570943;2722.387462820889;2729.5223335916135;2757.655293088364;1033.751899544104;1045.4511381524608;1047.0471870597719;1071.0681706914877;1071.9892801072046;20858.687119693215;21613.459663508223;21773.45566360822;21800.34598962034;21916.342509724735;1119.5074167366333;1120.1710734056903;1122.8428020077197;1131.7736452709491;1133.659902029388;11965.222260553037;12181.512739490321;12187.817182742267;12229.633111006506;12292.078094142975;604023;623894;625849;638665;650817;134417;134983.3250833759;138210;139078;139576;1108.7172770943519;1196.4615922834585;1229.3115855120982;1270.974580508403;1292.2440372382073;22699;22939.54120917539;22949.967251474056;23191.304260871526;23924.40188995289;65310;66209.66895165494;69184;70056.29943700497;70637.64681176562;82968.58515707383;83424.58287708522;84704;85806.57096714477;86473.56763216143;21586.78413215848;22058.33824985253;22226.777732222472;22256.109755609596;22269.554608908056;24480.75519244856;24991.250262492154;24991.500169996863;25014.874925625983;25116.62325065162;16788.992660440414;20007.59984800325;20058.39824805258;20200;20278.59442811165;17679.646407072043;17822.732659010384;18103.094845257947;18591.16339764687;18710.625787483903;19637.70543441821;19906.402807915787;20868.95655217203;20949.476263093544;21009.369718908456;21207.57584848325;21265.57468850645;21274.36176914695;21520.56958860783;21581.24465643695;19652.213911443952;19685.21259149618;19842.60314793725;19919.203231871143;20107.798922010592 19:00:50 INFO - PID 8337 | |3;mootools.html;1399.7200559888022;1455.9708805823884;1463.9560813175608;1495.5289083938558;1507.0505581483667;16720.163991800408;17407.3037078517;17409.390671326506;17431.128443577803;17435.476935691935;16907.577310567212;16947.322107115702;16956.74564881528;17021.48935531936;17062.232199551017;2856.3715982483873;2932.4183083870703;2990.790644654875;2992.7456166225898;2995.850207489617;2840.957385639217;2869.397426540429;2874.338902052529;2874.3676391193903;2891.4939885520057;2848.5442329227326;2874.310165560261;2880.683124856264;2881.942361152776;2881.985590072057;2805.6072149899032;2836.2767494289033;2850.6294181756343;2876.6116574262414;2881.9567706484418;2825.3642930340716;2829.264391258267;2840.332521857362;2870.9282267943468;2871.7794937151625;16609.33562657492;16727.16364181798;16924.238409271613;16929.06890121055;16950.49148525546;8438.324934005264;8779.604917778652;8785.64857405703;8785.692500762443;8792.824143517159;5406.729663516848;5492.80775172871;5575.4424557543925;5643.040683083886;5670.6030577859565;2046;2092.3199960012903;2117.544727883512;2155.1271734947372;2164.967525487119;31206.53190202149;31529.36941261162;31562.368752625047;31563.52654710181;31658.366832663447;7352.522086064496;7528.661210245552;7544.132424771112;7701.691932322757;7729.6521656524465;19835.30576429818;19865.404037878885;19877.900610496854;19879.30422435208;20015.399538013884;8530.232279094787;8696.260817830429;8748.300135989106;8760.780980475412;8782.780430489289;7852.371810255166;7931.841363172704;7932.167122452175;8051.758447246592;8060.113387527367;5512;5719.8856022880145;5798.420157984167;5834.737436815353;5847.386024467455;1548.41934274647;1573.622330640661;1589.3165938646262;1731.5151757507665;1761.3659082730208;1005.6781829814389;1005.8591797148405;1006.411249419098;1011.6964910526813;1021.8927012663563;9983.201343892617;10032.448215348226;10044.29689921713;10149.898501014895;10275.948620256851;1051.5215576912487;1070.6038765656756;1081.0162751895737;1083.2254937719567;1087.1194332590626;6323;6363.013732871413;6514.478841692653;6523.575967562188;6537.836554086186;24847.5030499389;24919;25589.616155757678;25604;25780.742192577833;25088.874555627106;25192.622110668355;25478.108266210966;25502.872485637825;25521.74478255231;12275.263484190977;12809.359532023362;12812.295323757282;12847.293398862965;12925.612231633066;9572.76068098303;9622.759431014281;9686.806263874823;9688.32181747271;9826.65606703762;20676.896615516827;20732.378028659165;21075.367738967856;21463.785362146802;21638.134474620838;21941.67087493721;21988;22145.446363841034;22335.10659573599;23137.190198342978;11945.522179112739;11956.76086478283;12008.759824803281;12027.518899244282;12144.514219431123;15344.386224550894;15400.614984625474;15460.84539154639;15473.148976806384;15559.766603501183;12834.871651283367;12922.806157907828;12984.870151298366;13103.344832758514;13212.339383030618;12126.75746485083;12363.258204507398;12537.561185358469;12584.559540416041;12769.808452873029;11157.27477713946;11288.830667539829;11291.887081129084;11304.208705390543;11305.943470282926;8878.73363799087;8880.600372983103;8917.643294268157;8989.235914947041;9015;8726.82546349082;8783.956080219557;8806.955965220133;8807.339449541181;8849.778755531162 19:00:50 INFO - PID 8337 | |4;prototype.html;527.4729657641129;569.0922977850329;571.3771988532499;571.645579740561;585.6895845202042;6188.195534580504;6275.309715931256;6290.119383286338;6311.999999999988;6379.5853269537565;6201.255849298079;6202.751889924409;6221.564490485668;6288.968555157217;6305.495560355172;5180.171172612383;5193.662411943231;5218.425973142951;5223.817166399177;5232.45059268777;4925.458199598042;5194.55846253067;5213.113770658997;5222.764975576109;5247.763850626731;4985.252212168168;5028.145215313405;5030.798768049273;5043.773030213631;5049.520295571915;5003.923371800698;5020.523050310215;5038.773255203525;5041.8487445376695;5053.848384548451;4483.663725220622;4533.954660453419;4562.270036794097;4579.496255411902;4606.769661516911;6081.726322315506;6148.754049838001;6168.506519478476;6172.290186628506;6205.441510264098;5875.472377181921;5903.557233207526;5953.3451320354725;5962.403759624046;5970.432808883149;6739.460843132538;6752.5948443093575;6761.3238676132;6773.932260677379;6789.864202715968;5143.228515722634;5146.768395422215;5150.510701483353;5174.327337446108;5182.170852663593;6761.830954226184;6820.93179068208;6961.756338528178;6992.720291188346;7014.333638304353;5241.816536421207;5246.160614301693;5260.395054568697;5276.261323414725;5282.4717528246865;5320;5324.1747529133045;5350.3312085989255;5351.919721204185;5368.812091576776;5838.868812883267;5879.559033072536;5961.344252132262;5963.612365196248;6000;6655.600663960178;6696.363845434676;6792.252852186256;6795.728170873209;6803.625800581016;1835.68748344934;1842.7788665360242;1844.588889499507;1848.879822811513;1880.6614809334178;1280.8920283954312;1316.1182008054627;1317.960461186166;1329.6144118205805;1339.8593147719544;6121.408433807153;6164.383561643889;6214.285357183981;6222.719977601018;6274.843128921722;6643.2028156620545;6701.865962680817;6722.025306330653;6729.8654026919185;6809.693563789641;6144.754209831646;6167.691615419211;6189.690515474298;6190.659513726789;6235.971064774261;3500.579930408367;3561.216532362876;3598.8200589970397;3611.638836116367;3611.819409029538;6971.163460384786;7054.365107140382;7072.762266603324;7113.146422429341;7144;6909.827254318682;6912.55068420551;6922.5154239202775;7089.151450053726;7100.4319654428555;7023.508354415244;7028.1375435509635;7099.787006389816;7108.573485590881;7187.96406017977;6661.16735408074;6744.258131605421;6750.696218670073;6767.526273160832;6779.254282029072;6665.933450647873;6673.699683514351;6687.1975362956755;6705.564138330993;6730.798076057726;7005.579665220103;7027.332403421667;7030.156381234285;7051.682674279567;7065.929340706733;5218.791248350175;5223.425423203521;5249.632525723163;5289.391719952255;5299.178627312773;6553.5084868634085;6622.90065649006;6665.700043498151;6676.563054485175;6691.2639609643875;6507.577007494498;6542.705578249085;6547.672616369257;6562.3109573496;6624.271330153776;6423.775167869102;6448.258450278278;6547.148870646785;6624.966875165594;6676.432503237279;6489.318621544669;6500.122483464672;6553.311902250386;6566.507511936528;6586.485108425185;6594.790745100445;6650.800475985729;6651.401373876374;6673.798716231125;6714.3549830291895;6439.83900402475;6450.161479007699;6466.0925027118055;6475.931471307182;6540.967295163684 19:00:50 INFO - PID 8337 | |5;yui.html;978.8531720241967;995.0298459002473;998.6354980432139;1003.6437064841986;1014.4978235773291;23200.187993420233;24914.999999999978;25124.87437562812;25125.120620778278;25155.62266566003;22151.778482215173;22689.432764180863;22847.42881427965;22899.198528051522;22902.770972290273;1058.8041212375715;1087.3475914451305;1089.6622047165365;1090.2858627598935;1091.0889407344876;1025.8615086963239;1072.1851392941383;1074.4949873559415;1075.3010543146977;1077.0468135699923;1139.880312567181;1139.903108235801;1140.1278022312895;1140.4297851074464;1140.8402823604702;1128.8758236594051;1133.4162906103322;1134.160721066413;1135.1429670598727;1137.1357768096223;836.6569706420399;839.1482645115213;839.9748007559783;840.2143995364293;842.6713581703141;19153.799319286558;19487.415377538695;19508.90245548763;19588.804111958983;21251;23205.187818426275;23586.17448389315;23782.7621723784;23794.40513987164;23827;17599;17737.219369075443;17809.109544522853;17825.643487130186;17902.91048544762;3844.3272427325105;4009.258287216845;4026.7382620129597;4031.21391328691;4044.4539987101953;155693.22153389273;158257;158748.20625896796;160259;160282.1985890075;17218.536424404065;17298.481045568653;17593.120343983006;17751.289948402176;17852.107394630475;33459.66540334614;33671.15822104418;33718.15704607355;33776.83111584427;33883.491747623804;9361;9383.483908385104;9416.05839416053;9434.95282523583;9435.150836424755;4780.856574302707;4950.133726597831;4971.204607262821;4982.177940639826;5015.122353588107;6254.749810007549;6361.14124593174;6375.808725738235;6406.135171751847;6410.326915673787;1112.67732357617;1113.0872684398878;1118.7874303882236;1122.2985633978763;1132.3828513460185;704.968276427562;708.2351060854265;713.2261496276598;719.3238355945394;725.5066554742825;12823;13232.73534529304;13373.197608143542;14214.360353784105;14231.07498012626;739.8298391370015;741.4476215219696;744.7058411927259;746.1941103608091;766.3715753082419;6024.3975602439405;6036.969815150984;6106.389361063858;6129.908051379233;6174.104754810527;143241.28379358244;143361;144782;145921;146445;127412.36293818471;128245;128939;129493;131029.34485327703;108762.45618771855;110379;111755;112548;113915.4304228457;11711.121665874924;11862.169648124893;11907.404629768651;11916.52333906634;11945.402729863647;53534;53615.463845361046;53798.46201538091;54607;55176.44823551713;69130.65434672794;70820;70990.64504677443;71066.64466677634;74404.2559574419;15519.689606208038;15796.21018949071;15816.446424375092;15853.048817071012;15857.048577085412;18205;18241.908790455964;18263.54341141482;18343.54141146482;18506.629867402306;17296.135193240538;17526;17562.20970056325;17688.204030818386;17740.11299435049;15574.688506229586;15620.765688514908;15785.763213552036;15849;15910.681786363977;16978.66042679164;17230.05234712103;17349.479515614552;17537.91231043888;17628.1185940705;12983.675408114872;13463.326833658082;13608.455661773814;13623.79564306556;13641.38613762403;13233.933830330787;13359.26524041187;13389.393272807325;13420;13439.328033598085 19:00:50 INFO - PID 8337 | __end_tp_report 19:00:50 INFO - PID 8337 | __start_cc_report 19:00:50 INFO - PID 8337 | _x_x_mozilla_cycle_collect,260 19:00:50 INFO - PID 8337 | __end_cc_report 19:00:50 INFO - PID 8337 | __startTimestamp1506477650120__endTimestamp 19:00:50 INFO - PID 8337 | 19:00:50 INFO - PID 8337 | ------- Summary: start ------- 19:00:50 INFO - PID 8337 | Number of tests: 6 19:00:50 INFO - PID 8337 | 19:00:50 INFO - PID 8337 | [#0] dojo.html Cycles:165 Average:6198.44 Median:6425.55 stddev:842.28 (13.1%) stddev-sans-first:824.48 19:00:50 INFO - PID 8337 | Values: 3850.7 3871.6 3881.1 3919.0 3925.3 6177.9 6192.4 6209.4 6222.3 6275.7 6253.8 6353.2 6354.4 6381.7 6396.6 780.9 5432.5 5580.2 5643.4 5700.8 5539.2 5550.5 5577.8 5590.4 5603.0 5583.5 5597.7 5623.2 5625.9 5628.8 5589.6 5653.5 5655.8 5661.0 5665.1 5560.9 5608.4 5647.4 5658.7 5677.2 6002.7 6104.6 6210.1 6299.9 6312.8 6578.6 6579.6 6580.7 6585.9 6592.1 6594.1 6667.8 6674.9 6683.0 6693.1 6348.8 6359.2 6379.9 6381.4 6385.9 6887.4 6955.8 6957.1 7038.9 7042.2 6557.4 6671.0 6678.0 6718.8 6787.6 6744.7 6752.5 6774.4 6777.3 6788.0 6718.3 6801.6 6823.4 6837.1 6845.3 6755.7 6756.0 6789.1 6862.0 6864.2 4927.8 4961.7 5006.0 5049.8 5050.2 4478.2 4495.7 4519.1 4520.8 4560.0 6200.8 6360.5 6368.3 6374.3 6385.9 6754.9 6767.1 6792.0 6855.0 6859.1 6166.2 6269.9 6271.0 6280.7 6286.6 5459.5 5463.1 5522.1 5525.4 5560.8 6987.0 7089.0 7161.0 7172.1 7191.4 6579.8 6721.0 6737.7 6816.1 6865.3 6956.2 6959.1 6961.5 6970.8 6973.7 6613.2 6621.3 6626.5 6689.7 6772.9 6682.5 6801.1 6894.2 6901.5 6903.6 6536.4 6538.3 6545.1 6633.8 6634.2 6304.6 6421.0 6425.6 6426.4 6426.6 6180.8 6336.9 6367.2 6412.8 6448.1 6534.1 6635.8 6694.7 6729.1 6750.2 6299.2 6414.6 6433.0 6433.5 6540.1 19:00:50 INFO - PID 8337 | 19:00:50 INFO - PID 8337 | [#1] ext.html Cycles:180 Average:43127.25 Median:39246.21 stddev:64472.75 (164.3%) stddev-sans-first:64575.13 19:00:50 INFO - PID 8337 | Values: 757.5 777.7 777.7 777.8 780.2 43837.8 44662.3 44697.3 44815.0 44849.3 40709.0 40723.8 40904.8 41060.8 41124.6 7296.8 7320.2 7382.9 7385.2 7390.7 7332.4 7337.1 7370.7 7403.1 7412.0 8369.9 8498.7 8506.4 8510.8 8515.4 8362.8 8380.3 8383.6 8444.7 8451.5 8144.8 8257.9 8280.6 8282.8 8286.0 40485.8 40851.0 40971.6 41082.8 41162.4 3691.7 3748.7 3748.7 3750.2 3752.2 33318.2 33639.2 33799.7 33819.8 33849.3 5469.0 5487.5 5492.3 5504.1 5555.2 221413.0 222397.0 222530.0 223507.0 223799.0 48267.3 48664.5 53518.0 53935.7 54798.0 56322.0 56372.7 56578.7 56739.4 56750.7 16105.3 16134.2 16223.3 16228.5 16282.5 13107.9 13126.5 13191.2 13207.1 13207.1 14946.7 15042.3 15075.5 15179.7 15233.2 6023.7 6032.7 6087.3 6237.5 6258.9 1092.6 1093.1 1111.7 1115.1 1125.5 24931.8 25181.4 25226.5 25419.1 25482.6 1186.1 1201.7 1205.2 1207.9 1210.6 13216.7 13531.9 13535.8 13554.0 13798.5 286466.0 290061.0 290238.0 290972.0 291109.0 59165.7 59645.4 59963.0 59971.4 60173.0 1469.5 1507.2 1523.4 1540.9 1553.5 24864.5 24948.6 25011.7 25067.5 25183.5 40989.4 41086.0 41156.8 41158.8 41228.4 223647.0 224432.0 225665.0 225762.0 225927.0 36665.3 39727.8 39906.0 40207.6 40367.8 52018.5 53071.2 53150.2 53409.2 53743.2 38308.0 38469.4 38558.0 38760.0 38764.6 37527.8 37820.8 37941.6 37979.6 38404.2 43705.0 44332.6 45170.0 45215.3 45413.3 36650.5 36653.8 36676.6 36688.6 36760.0 26483.7 26973.1 27238.6 27271.5 27689.2 19:00:50 INFO - PID 8337 | 19:00:50 INFO - PID 8337 | [#2] jquery.html Cycles:180 Average:41369.28 Median:23745.47 stddev:105135.06 (442.8%) stddev-sans-first:105385.44 19:00:50 INFO - PID 8337 | Values: 605.0 625.1 626.4 640.8 644.3 22632.7 23566.5 24063.8 24146.4 24156.8 24476.1 25829.0 25841.4 25850.7 25857.5 6446.8 6590.8 6599.3 6600.7 6605.8 6411.6 6438.0 6613.8 6645.4 6651.8 6554.9 6595.2 6611.7 6614.9 6615.7 6397.9 6593.6 6601.2 6602.6 6620.6 6191.8 6192.2 6221.7 6227.4 6241.0 29699.1 30324.4 30337.9 30345.6 30360.0 2245.0 2277.2 2280.2 2280.7 2283.6 19838.7 20462.9 20532.4 20689.5 20706.8 2469.9 2495.9 2548.2 2576.2 2583.5 136313.0 142584.3 154652.0 160765.2 161208.0 15073.2 15600.9 16017.4 16628.4 16960.7 26039.7 26106.2 26106.2 26172.5 26201.4 10259.3 10300.9 10404.0 10657.4 10723.7 9532.1 9583.9 9645.4 9648.6 9760.4 9628.2 9816.9 9857.5 9878.8 9893.3 2674.4 2713.1 2722.4 2729.5 2757.7 1033.8 1045.5 1047.0 1071.1 1072.0 20858.7 21613.5 21773.5 21800.3 21916.3 1119.5 1120.2 1122.8 1131.8 1133.7 11965.2 12181.5 12187.8 12229.6 12292.1 604023.0 623894.0 625849.0 638665.0 650817.0 134417.0 134983.3 138210.0 139078.0 139576.0 1108.7 1196.5 1229.3 1271.0 1292.2 22699.0 22939.5 22950.0 23191.3 23924.4 65310.0 66209.7 69184.0 70056.3 70637.6 82968.6 83424.6 84704.0 85806.6 86473.6 21586.8 22058.3 22226.8 22256.1 22269.6 24480.8 24991.3 24991.5 25014.9 25116.6 16789.0 20007.6 20058.4 20200.0 20278.6 17679.6 17822.7 18103.1 18591.2 18710.6 19637.7 19906.4 20869.0 20949.5 21009.4 21207.6 21265.6 21274.4 21520.6 21581.2 19652.2 19685.2 19842.6 19919.2 20107.8 19:00:50 INFO - PID 8337 | 19:00:50 INFO - PID 8337 | [#3] mootools.html Cycles:180 Average:10652.56 Median:25003.94 stddev:7811.01 (31.2%) stddev-sans-first:7801.98 19:00:50 INFO - PID 8337 | Values: 1399.7 1456.0 1464.0 1495.5 1507.1 16720.2 17407.3 17409.4 17431.1 17435.5 16907.6 16947.3 16956.7 17021.5 17062.2 2856.4 2932.4 2990.8 2992.7 2995.9 2841.0 2869.4 2874.3 2874.4 2891.5 2848.5 2874.3 2880.7 2881.9 2882.0 2805.6 2836.3 2850.6 2876.6 2882.0 2825.4 2829.3 2840.3 2870.9 2871.8 16609.3 16727.2 16924.2 16929.1 16950.5 8438.3 8779.6 8785.6 8785.7 8792.8 5406.7 5492.8 5575.4 5643.0 5670.6 2046.0 2092.3 2117.5 2155.1 2165.0 31206.5 31529.4 31562.4 31563.5 31658.4 7352.5 7528.7 7544.1 7701.7 7729.7 19835.3 19865.4 19877.9 19879.3 20015.4 8530.2 8696.3 8748.3 8760.8 8782.8 7852.4 7931.8 7932.2 8051.8 8060.1 5512.0 5719.9 5798.4 5834.7 5847.4 1548.4 1573.6 1589.3 1731.5 1761.4 1005.7 1005.9 1006.4 1011.7 1021.9 9983.2 10032.4 10044.3 10149.9 10275.9 1051.5 1070.6 1081.0 1083.2 1087.1 6323.0 6363.0 6514.5 6523.6 6537.8 24847.5 24919.0 25589.6 25604.0 25780.7 25088.9 25192.6 25478.1 25502.9 25521.7 12275.3 12809.4 12812.3 12847.3 12925.6 9572.8 9622.8 9686.8 9688.3 9826.7 20676.9 20732.4 21075.4 21463.8 21638.1 21941.7 21988.0 22145.4 22335.1 23137.2 11945.5 11956.8 12008.8 12027.5 12144.5 15344.4 15400.6 15460.8 15473.1 15559.8 12834.9 12922.8 12984.9 13103.3 13212.3 12126.8 12363.3 12537.6 12584.6 12769.8 11157.3 11288.8 11291.9 11304.2 11305.9 8878.7 8880.6 8917.6 8989.2 9015.0 8726.8 8784.0 8807.0 8807.3 8849.8 19:00:50 INFO - PID 8337 | 19:00:50 INFO - PID 8337 | [#4] prototype.html Cycles:180 Average:5678.39 Median:6222.14 stddev:1573.07 (25.3%) stddev-sans-first:1529.24 19:00:50 INFO - PID 8337 | Values: 527.5 569.1 571.4 571.6 585.7 6188.2 6275.3 6290.1 6312.0 6379.6 6201.3 6202.8 6221.6 6289.0 6305.5 5180.2 5193.7 5218.4 5223.8 5232.5 4925.5 5194.6 5213.1 5222.8 5247.8 4985.3 5028.1 5030.8 5043.8 5049.5 5003.9 5020.5 5038.8 5041.8 5053.8 4483.7 4534.0 4562.3 4579.5 4606.8 6081.7 6148.8 6168.5 6172.3 6205.4 5875.5 5903.6 5953.3 5962.4 5970.4 6739.5 6752.6 6761.3 6773.9 6789.9 5143.2 5146.8 5150.5 5174.3 5182.2 6761.8 6820.9 6961.8 6992.7 7014.3 5241.8 5246.2 5260.4 5276.3 5282.5 5320.0 5324.2 5350.3 5351.9 5368.8 5838.9 5879.6 5961.3 5963.6 6000.0 6655.6 6696.4 6792.3 6795.7 6803.6 1835.7 1842.8 1844.6 1848.9 1880.7 1280.9 1316.1 1318.0 1329.6 1339.9 6121.4 6164.4 6214.3 6222.7 6274.8 6643.2 6701.9 6722.0 6729.9 6809.7 6144.8 6167.7 6189.7 6190.7 6236.0 3500.6 3561.2 3598.8 3611.6 3611.8 6971.2 7054.4 7072.8 7113.1 7144.0 6909.8 6912.6 6922.5 7089.2 7100.4 7023.5 7028.1 7099.8 7108.6 7188.0 6661.2 6744.3 6750.7 6767.5 6779.3 6665.9 6673.7 6687.2 6705.6 6730.8 7005.6 7027.3 7030.2 7051.7 7065.9 5218.8 5223.4 5249.6 5289.4 5299.2 6553.5 6622.9 6665.7 6676.6 6691.3 6507.6 6542.7 6547.7 6562.3 6624.3 6423.8 6448.3 6547.1 6625.0 6676.4 6489.3 6500.1 6553.3 6566.5 6586.5 6594.8 6650.8 6651.4 6673.8 6714.4 6439.8 6450.2 6466.1 6475.9 6541.0 19:00:50 INFO - PID 8337 | 19:00:50 INFO - PID 8337 | [#5] yui.html Cycles:180 Average:27939.68 Median:17738.67 stddev:41378.91 (233.3%) stddev-sans-first:41445.47 19:00:50 INFO - PID 8337 | Values: 978.9 995.0 998.6 1003.6 1014.5 23200.2 24915.0 25124.9 25125.1 25155.6 22151.8 22689.4 22847.4 22899.2 22902.8 1058.8 1087.3 1089.7 1090.3 1091.1 1025.9 1072.2 1074.5 1075.3 1077.0 1139.9 1139.9 1140.1 1140.4 1140.8 1128.9 1133.4 1134.2 1135.1 1137.1 836.7 839.1 840.0 840.2 842.7 19153.8 19487.4 19508.9 19588.8 21251.0 23205.2 23586.2 23782.8 23794.4 23827.0 17599.0 17737.2 17809.1 17825.6 17902.9 3844.3 4009.3 4026.7 4031.2 4044.5 155693.2 158257.0 158748.2 160259.0 160282.2 17218.5 17298.5 17593.1 17751.3 17852.1 33459.7 33671.2 33718.2 33776.8 33883.5 9361.0 9383.5 9416.1 9435.0 9435.2 4780.9 4950.1 4971.2 4982.2 5015.1 6254.7 6361.1 6375.8 6406.1 6410.3 1112.7 1113.1 1118.8 1122.3 1132.4 705.0 708.2 713.2 719.3 725.5 12823.0 13232.7 13373.2 14214.4 14231.1 739.8 741.4 744.7 746.2 766.4 6024.4 6037.0 6106.4 6129.9 6174.1 143241.3 143361.0 144782.0 145921.0 146445.0 127412.4 128245.0 128939.0 129493.0 131029.3 108762.5 110379.0 111755.0 112548.0 113915.4 11711.1 11862.2 11907.4 11916.5 11945.4 53534.0 53615.5 53798.5 54607.0 55176.4 69130.7 70820.0 70990.6 71066.6 74404.3 15519.7 15796.2 15816.4 15853.0 15857.0 18205.0 18241.9 18263.5 18343.5 18506.6 17296.1 17526.0 17562.2 17688.2 17740.1 15574.7 15620.8 15785.8 15849.0 15910.7 16978.7 17230.1 17349.5 17537.9 17628.1 12983.7 13463.3 13608.5 13623.8 13641.4 13233.9 13359.3 13389.4 13420.0 13439.3 19:00:50 INFO - PID 8337 | -------- Summary: end -------- 19:00:50 INFO - PID 8337 | 19:00:50 INFO - TEST-INFO | 8337: exit 0 19:00:50 INFO - TEST-OK | dromaeo_css | took 1108017ms 19:00:50 INFO - TEST-START | kraken 19:00:50 INFO - Initialising browser for kraken test... 19:00:50 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:40127/getInfo.html -profile /tmp/tmpLQSGhP/profile 19:00:50 INFO - TEST-INFO | started process 8708 (/builds/slave/test/build/application/firefox/firefox http://localhost:40127/getInfo.html) 19:00:56 INFO - TEST-INFO | 8708: exit 0 19:00:56 INFO - Browser initialized. 19:00:56 INFO - Running cycle 1/1 for kraken test... 19:00:56 INFO - Using env: {'DISPLAY': ':0', 19:00:56 INFO - 'HOME': '/home/cltbld', 19:00:56 INFO - 'JSGC_DISABLE_POISONING': '1', 19:00:56 INFO - 'LANG': 'en_US.UTF-8', 19:00:56 INFO - 'LANGUAGE': 'en_US:en', 19:00:56 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 19:00:56 INFO - 'LOGNAME': 'cltbld', 19:00:56 INFO - 'MAIL': '/var/mail/cltbld', 19:00:56 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:00:56 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 19:00:56 INFO - 'MOZ_CRASHREPORTER': '1', 19:00:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:00:56 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 19:00:56 INFO - 'MOZ_NO_REMOTE': '1', 19:00:56 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:00:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:00:56 INFO - 'NO_EM_RESTART': '1', 19:00:56 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:00:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:00:56 INFO - 'PWD': '/builds/slave/test', 19:00:56 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:00:56 INFO - 'RUST_BACKTRACE': 'full', 19:00:56 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 19:00:56 INFO - 'SHELL': '/bin/bash', 19:00:56 INFO - 'SHLVL': '1', 19:00:56 INFO - 'STYLO_FORCE_DISABLED': '1', 19:00:56 INFO - 'TERM': 'linux', 19:00:56 INFO - 'TMOUT': '86400', 19:00:56 INFO - 'USER': 'cltbld', 19:00:56 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1506475638.995008-257981642', 19:00:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:00:56 INFO - '_': '/tools/buildbot/bin/python'} 19:00:56 INFO - TEST-INFO | started process 8944 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpLQSGhP/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 19:00:57 INFO - PID 8944 | 19:00:57 INFO - PID 8944 | (/builds/slave/test/build/application/firefox/firefox:8993): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 19:00:57 INFO - PID 8944 | 19:01:08 INFO - PID 8944 | RSS: Main: 144146432 19:01:08 INFO - PID 8944 | 19:01:10 INFO - PID 8944 | Cycle 1(1): loaded http://localhost:40127/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:40127/tests/kraken/driver.html?testName=audio-beat-detection) 19:01:11 INFO - PID 8944 | RSS: Main: 149889024 19:01:11 INFO - PID 8944 | 19:01:14 INFO - PID 8944 | Cycle 1(1): loaded http://localhost:40127/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:40127/tests/kraken/driver.html?testName=audio-dft) 19:01:14 INFO - PID 8944 | RSS: Main: 150917120 19:01:14 INFO - PID 8944 | 19:01:17 INFO - PID 8944 | Cycle 1(1): loaded http://localhost:40127/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:40127/tests/kraken/driver.html?testName=audio-fft) 19:01:18 INFO - PID 8944 | RSS: Main: 147038208 19:01:18 INFO - PID 8944 | 19:01:20 INFO - PID 8944 | Cycle 1(1): loaded http://localhost:40127/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:40127/tests/kraken/driver.html?testName=audio-oscillator) 19:01:20 INFO - PID 8944 | RSS: Main: 148480000 19:01:20 INFO - PID 8944 | 19:01:22 INFO - PID 8944 | Cycle 1(1): loaded http://localhost:40127/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:40127/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:01:23 INFO - PID 8944 | RSS: Main: 148185088 19:01:23 INFO - PID 8944 | 19:01:26 INFO - PID 8944 | Cycle 1(1): loaded http://localhost:40127/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:40127/tests/kraken/driver.html?testName=imaging-darkroom) 19:01:27 INFO - PID 8944 | RSS: Main: 148230144 19:01:27 INFO - PID 8944 | 19:01:30 INFO - PID 8944 | Cycle 1(1): loaded http://localhost:40127/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:40127/tests/kraken/driver.html?testName=imaging-desaturate) 19:01:31 INFO - PID 8944 | RSS: Main: 150568960 19:01:31 INFO - PID 8944 | 19:01:34 INFO - PID 8944 | Cycle 1(1): loaded http://localhost:40127/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:40127/tests/kraken/driver.html?testName=json-parse-financial) 19:01:34 INFO - PID 8944 | RSS: Main: 151711744 19:01:34 INFO - PID 8944 | 19:01:36 INFO - PID 8944 | Cycle 1(1): loaded http://localhost:40127/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:40127/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:01:36 INFO - PID 8944 | RSS: Main: 151494656 19:01:36 INFO - PID 8944 | 19:01:38 INFO - PID 8944 | Cycle 1(1): loaded http://localhost:40127/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:40127/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:01:38 INFO - PID 8944 | RSS: Main: 151691264 19:01:38 INFO - PID 8944 | 19:01:41 INFO - PID 8944 | Cycle 1(1): loaded http://localhost:40127/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:40127/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:01:41 INFO - PID 8944 | RSS: Main: 148529152 19:01:41 INFO - PID 8944 | 19:01:44 INFO - PID 8944 | Cycle 1(1): loaded http://localhost:40127/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:40127/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:01:44 INFO - PID 8944 | RSS: Main: 148303872 19:01:44 INFO - PID 8944 | 19:01:47 INFO - PID 8944 | Cycle 1(1): loaded http://localhost:40127/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:40127/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:01:48 INFO - PID 8944 | RSS: Main: 148815872 19:01:48 INFO - PID 8944 | 19:01:49 INFO - PID 8944 | Cycle 1(1): loaded http://localhost:40127/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:40127/tests/kraken/driver.html?testName=ai-astar) 19:01:49 INFO - PID 8944 | RSS: Main: 149954560 19:01:49 INFO - PID 8944 | 19:01:49 INFO - PID 8944 | __start_tp_report 19:01:49 INFO - PID 8944 | _x_x_mozilla_page_load 19:01:49 INFO - PID 8944 | _x_x_mozilla_page_load_details 19:01:49 INFO - PID 8944 | |i|pagename|runs| 19:01:49 INFO - PID 8944 | |0;ai-astar;104;104;105;106;105;107;112;106;103;105 19:01:49 INFO - PID 8944 | |1;audio-beat-detection;116;114;116;115;116;115;115;146;118;113 19:01:49 INFO - PID 8944 | |2;audio-dft;163;162;163;161;161;162;161;160;162;164 19:01:49 INFO - PID 8944 | |3;audio-fft;73;74;74;73;74;74;74;76;74;75 19:01:49 INFO - PID 8944 | |4;audio-oscillator;80;78;79;77;78;77;79;79;78;79 19:01:49 INFO - PID 8944 | |5;imaging-gaussian-blur;114;114;110;114;114;113;110;114;112;115 19:01:49 INFO - PID 8944 | |6;imaging-darkroom;149;150;149;151;150;150;150;154;150;150 19:01:49 INFO - PID 8944 | |7;imaging-desaturate;94;95;95;93;100;100;96;95;100;95 19:01:49 INFO - PID 8944 | |8;json-parse-financial;48;43;46;44;45;45;46;44;44;44 19:01:49 INFO - PID 8944 | |9;json-stringify-tinderbox;35;36;36;36;35;37;36;37;36;36 19:01:49 INFO - PID 8944 | |10;stanford-crypto-aes;73;73;73;72;73;75;76;71;72;71 19:01:49 INFO - PID 8944 | |11;stanford-crypto-ccm;107;111;103;107;107;110;105;119;105;103 19:01:49 INFO - PID 8944 | |12;stanford-crypto-pbkdf2;156;162;152;150;164;155;153;155;161;150 19:01:49 INFO - PID 8944 | |13;stanford-crypto-sha256-iterative;60;60;59;59;60;64;58;58;59;61 19:01:49 INFO - PID 8944 | __end_tp_report 19:01:49 INFO - PID 8944 | __start_cc_report 19:01:49 INFO - PID 8944 | _x_x_mozilla_cycle_collect,703 19:01:49 INFO - PID 8944 | __end_cc_report 19:01:49 INFO - PID 8944 | __startTimestamp1506477709980__endTimestamp 19:01:49 INFO - PID 8944 | 19:01:49 INFO - PID 8944 | ------- Summary: start ------- 19:01:49 INFO - PID 8944 | Number of tests: 14 19:01:49 INFO - PID 8944 | 19:01:49 INFO - PID 8944 | [#0] ai-astar Cycles:10 Average:105.70 Median:105.50 stddev:2.50 (2.4%) stddev-sans-first:2.57 19:01:49 INFO - PID 8944 | Values: 104.0 104.0 105.0 106.0 105.0 107.0 112.0 106.0 103.0 105.0 19:01:49 INFO - PID 8944 | 19:01:49 INFO - PID 8944 | [#1] audio-beat-detection Cycles:10 Average:118.40 Median:116.00 stddev:9.79 (8.4%) stddev-sans-first:10.34 19:01:49 INFO - PID 8944 | Values: 116.0 114.0 116.0 115.0 116.0 115.0 115.0 146.0 118.0 113.0 19:01:49 INFO - PID 8944 | 19:01:49 INFO - PID 8944 | [#2] audio-dft Cycles:10 Average:161.90 Median:162.00 stddev:1.20 (0.7%) stddev-sans-first:1.20 19:01:49 INFO - PID 8944 | Values: 163.0 162.0 163.0 161.0 161.0 162.0 161.0 160.0 162.0 164.0 19:01:49 INFO - PID 8944 | 19:01:49 INFO - PID 8944 | [#3] audio-fft Cycles:10 Average:74.10 Median:74.00 stddev:0.88 (1.2%) stddev-sans-first:0.83 19:01:49 INFO - PID 8944 | Values: 73.0 74.0 74.0 73.0 74.0 74.0 74.0 76.0 74.0 75.0 19:01:49 INFO - PID 8944 | 19:01:49 INFO - PID 8944 | [#4] audio-oscillator Cycles:10 Average:78.40 Median:79.00 stddev:0.97 (1.2%) stddev-sans-first:0.83 19:01:49 INFO - PID 8944 | Values: 80.0 78.0 79.0 77.0 78.0 77.0 79.0 79.0 78.0 79.0 19:01:49 INFO - PID 8944 | 19:01:49 INFO - PID 8944 | [#5] imaging-gaussian-blur Cycles:10 Average:113.00 Median:114.00 stddev:1.76 (1.5%) stddev-sans-first:1.83 19:01:49 INFO - PID 8944 | Values: 114.0 114.0 110.0 114.0 114.0 113.0 110.0 114.0 112.0 115.0 19:01:49 INFO - PID 8944 | 19:01:49 INFO - PID 8944 | [#6] imaging-darkroom Cycles:10 Average:150.30 Median:150.00 stddev:1.42 (0.9%) stddev-sans-first:1.42 19:01:49 INFO - PID 8944 | Values: 149.0 150.0 149.0 151.0 150.0 150.0 150.0 154.0 150.0 150.0 19:01:49 INFO - PID 8944 | 19:01:49 INFO - PID 8944 | [#7] imaging-desaturate Cycles:10 Average:96.30 Median:95.00 stddev:2.67 (2.8%) stddev-sans-first:2.70 19:01:49 INFO - PID 8944 | Values: 94.0 95.0 95.0 93.0 100.0 100.0 96.0 95.0 100.0 95.0 19:01:49 INFO - PID 8944 | 19:01:49 INFO - PID 8944 | [#8] json-parse-financial Cycles:10 Average:44.90 Median:45.00 stddev:1.45 (3.2%) stddev-sans-first:1.01 19:01:49 INFO - PID 8944 | Values: 48.0 43.0 46.0 44.0 45.0 45.0 46.0 44.0 44.0 44.0 19:01:49 INFO - PID 8944 | 19:01:49 INFO - PID 8944 | [#9] json-stringify-tinderbox Cycles:10 Average:36.00 Median:36.00 stddev:0.67 (1.9%) stddev-sans-first:0.60 19:01:49 INFO - PID 8944 | Values: 35.0 36.0 36.0 36.0 35.0 37.0 36.0 37.0 36.0 36.0 19:01:49 INFO - PID 8944 | 19:01:49 INFO - PID 8944 | [#10] stanford-crypto-aes Cycles:10 Average:72.90 Median:73.00 stddev:1.60 (2.2%) stddev-sans-first:1.69 19:01:49 INFO - PID 8944 | Values: 73.0 73.0 73.0 72.0 73.0 75.0 76.0 71.0 72.0 71.0 19:01:49 INFO - PID 8944 | 19:01:49 INFO - PID 8944 | [#11] stanford-crypto-ccm Cycles:10 Average:107.70 Median:107.00 stddev:4.76 (4.5%) stddev-sans-first:5.04 19:01:49 INFO - PID 8944 | Values: 107.0 111.0 103.0 107.0 107.0 110.0 105.0 119.0 105.0 103.0 19:01:49 INFO - PID 8944 | 19:01:49 INFO - PID 8944 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:155.80 Median:155.50 stddev:4.98 (3.2%) stddev-sans-first:5.29 19:01:49 INFO - PID 8944 | Values: 156.0 162.0 152.0 150.0 164.0 155.0 153.0 155.0 161.0 150.0 19:01:49 INFO - PID 8944 | 19:01:49 INFO - PID 8944 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:59.80 Median:60.00 stddev:1.75 (2.9%) stddev-sans-first:1.86 19:01:49 INFO - PID 8944 | Values: 60.0 60.0 59.0 59.0 60.0 64.0 58.0 58.0 59.0 61.0 19:01:49 INFO - PID 8944 | -------- Summary: end -------- 19:01:49 INFO - PID 8944 | 19:01:50 INFO - PID 8944 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 19:01:50 INFO - TEST-INFO | 8944: exit 0 19:01:50 INFO - TEST-OK | kraken | took 59898ms 19:01:50 INFO - SUITE-END | took 1167s 19:01:51 INFO - Completed test suite (00:19:28) 19:01:51 INFO - javascript benchmark 19:01:51 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s", "stylo_disabled"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 9155.794569200061, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3850.653441190293, 3871.612838716129, 3881.1461478474735, 3919.0202449387652, 3925.2934471795065, 6177.876442471148, 6192.41172088652, 6209.441150296472, 6222.346653601369, 6275.6548389838545, 6253.812385628427, 6353.174087368647, 6354.3963323484195, 6381.680915954195, 6396.648184349859, 780.9027105544086, 5432.483914028161, 5580.246666699984, 5643.379228284885, 5700.828975130753, 5539.224508568804, 5550.5282051025715, 5577.8047768328115, 5590.413006634306, 5603.0, 5583.5254003409755, 5597.720113994284, 5623.156526521055, 5625.943740562603, 5628.831135065934, 5589.608727389084, 5653.519450846683, 5655.830325090213, 5660.971695141539, 5665.065264231397, 5560.944390556083, 5608.4391560844, 5647.37878833328, 5658.660480371191, 5677.233573467571, 6002.669853158074, 6104.572679912408, 6210.068489726532, 6299.937000630027, 6312.842178945517, 6578.572392794453, 6579.638119903403, 6580.670966451707, 6585.901211481783, 6592.1100651411925, 6594.142761440982, 6667.766628167991, 6674.899876501856, 6683.0, 6693.062971184038, 6348.809535713982, 6359.236891572995, 6379.872402551923, 6381.425671689523, 6385.936140638581, 6887.449004079662, 6955.756548520879, 6957.095577574883, 7038.894416583756, 7042.225355210922, 6557.442617377576, 6670.966645166744, 6677.966610166918, 6718.798436046926, 6787.592744435349, 6744.696488658022, 6752.493562982796, 6774.390304872585, 6777.288384719632, 6788.0, 6718.328167183243, 6801.557898736665, 6823.38589526945, 6837.076994605764, 6845.315468453115, 6755.695993680296, 6756.020377045399, 6789.117414736152, 6862.0, 6864.24493305736, 4927.7536123193695, 4961.6526843121355, 5006.048850718352, 5049.823256186016, 5050.242463630485, 4478.171538265431, 4495.707778994355, 4519.118771839526, 4520.841770538015, 4560.0195957868555, 6200.782972596027, 6360.491160707133, 6368.29948705642, 6374.330695277022, 6385.936140638627, 6754.864902701918, 6767.120274364301, 6791.966040169867, 6855.0, 6859.07402500656, 6166.198394208814, 6269.905951410732, 6271.0, 6280.685965701697, 6286.5599408041, 5459.454054594509, 5463.098588732894, 5522.088855338824, 5525.392206857243, 5560.777568897199, 6986.965065174743, 7089.042979197846, 7160.964195178991, 7172.103487064117, 7191.352778249982, 6579.769708060195, 6720.966395168189, 6737.73049078051, 6816.113905192294, 6865.313468653295, 6956.16526016861, 6959.095317608679, 6961.547499412724, 6970.756023539152, 6973.721051157897, 6613.239477459962, 6621.33786621334, 6626.53614246998, 6689.732410703517, 6772.898406524005, 6682.46540276767, 6801.081853949653, 6894.207166175754, 6901.516893817385, 6903.551269167488, 6536.444402225674, 6538.280789113289, 6545.050967609765, 6633.767818126343, 6634.237062737847, 6304.5586808922935, 6420.967895160495, 6425.5502114851515, 6426.389492998158, 6426.614403135827, 6180.845478863064, 6336.9049464259, 6367.204099487564, 6412.775552855627, 6448.065030570635, 6534.1178940844275, 6635.767748128792, 6694.698738556679, 6729.1252137221845, 6750.189977202767, 6299.181106456132, 6414.583052101599, 6433.035044743138, 6433.5496515243485, 6540.117084193573], "value": 6143.750756892043, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [757.5454727163701, 777.6694904665512, 777.7122464688066, 777.8133248020473, 780.2041917244412, 43837.78081109594, 44662.33006504905, 44697.329540056846, 44815.0, 44849.32726009112, 40709.0, 40723.796381018125, 40904.79547602265, 41060.794696026554, 41124.58875411245, 7296.781096567098, 7320.2313757055545, 7382.889256661128, 7385.187629360766, 7390.704371825121, 7332.413406927433, 7337.0828646419195, 7370.668319925616, 7403.111626604788, 7412.0, 8369.874451883195, 8498.702545410912, 8506.447080939719, 8510.829783404328, 8515.361347898901, 8362.8327433451, 8380.329573634124, 8383.62273697682, 8444.746657600252, 8451.492910425393, 8144.796380090486, 8257.917420825775, 8280.5859707015, 8282.8343433131, 8286.047104582989, 40485.79757101196, 40851.0, 40971.59028409737, 41082.79458602718, 41162.38256426156, 3691.7046636269033, 3748.662620364153, 3748.737588368815, 3750.1562148516637, 3752.2307926874923, 33318.16704582405, 33639.159021024425, 33799.6620033799, 33819.83090084558, 33849.32301353959, 5468.9726551367385, 5487.506124448819, 5492.340919089735, 5504.091824848895, 5555.194496797982, 221413.0, 222397.0, 222530.0, 223507.0, 223799.0, 48267.275990860166, 48664.513354866, 53518.0, 53935.73032134893, 54798.0, 56322.0, 56372.71813640906, 56578.717106415024, 56739.43260567424, 56750.7162464185, 16105.27526261321, 16134.193290335435, 16223.269952851913, 16228.51314460568, 16282.51152465428, 13107.868921310665, 13126.474941002443, 13191.208527488381, 13207.07550471477, 13207.141535800141, 14946.70106597862, 15042.32309546073, 15075.54773356801, 15179.696406071816, 15233.23833808305, 6023.668698221552, 6032.698365081728, 6087.269527656709, 6237.500999919996, 6258.906116408258, 1092.6230450494568, 1093.1145771924766, 1111.6831702964616, 1115.0800589513683, 1125.4597793059377, 24931.750682493304, 25181.370465738135, 25226.495470090864, 25419.110331138323, 25482.617760733603, 1186.1400484648734, 1201.7236035711835, 1205.2166092040245, 1207.8792120788028, 1210.5702475621204, 13216.669583260495, 13531.932340338235, 13535.796963045563, 13554.0, 13798.517051903336, 286466.0, 290061.0, 290238.0, 290972.0, 291109.0, 59165.70417147973, 59645.40354596485, 59963.0, 59971.40028599746, 60173.0, 1469.463645769308, 1507.186119495482, 1523.4363285584404, 1540.9306581203873, 1553.4873491747696, 24864.50270994606, 24948.625770613817, 25011.749882500942, 25067.49865002726, 25183.496330073664, 40989.38515922204, 41085.972850677776, 41156.79421602993, 41158.794206028775, 41228.38157427701, 223647.0, 224432.0, 225665.0, 225762.0, 225927.0, 36665.26669466649, 39727.80136099301, 39906.0, 40207.59792402039, 40367.79816100901, 52018.47981520136, 53071.20393194028, 53150.2027469596, 53409.198862017874, 53743.193852093034, 38308.0, 38469.42295865508, 38558.0, 38760.0, 38764.61235387723, 37527.81236093802, 37820.810895945346, 37941.62058379492, 37979.62020379761, 38404.23191536209, 43705.0, 44332.556674432846, 45170.0, 45215.32177017413, 45413.31880021736, 36650.45024324691, 36653.81673091617, 36676.63323366732, 36688.63311366852, 36760.0, 26483.73516264813, 26973.055943041898, 27238.5914211283, 27271.454570908074, 27689.169324920284], "value": 18709.486174146496, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [604.9667268300244, 625.1279465146124, 626.4236902050113, 640.839790052487, 644.3492073006264, 22632.660510092363, 23566.52866942662, 24063.75936240637, 24146.396340091484, 24156.75843241567, 24476.14333498328, 25829.0, 25841.353966150855, 25850.741492585068, 25857.48285034298, 6446.774362897299, 6590.835229119262, 6599.307072757363, 6600.6699665016795, 6605.768798092067, 6411.583247088947, 6437.9678101609425, 6613.801585952405, 6645.4019138277545, 6651.8337041574105, 6554.9344506555035, 6595.241547222059, 6611.702473388685, 6614.900776488333, 6615.669216539178, 6397.904031439532, 6593.571417857848, 6601.2078550574, 6602.636854972975, 6620.602763834186, 6191.752329906798, 6192.164057852222, 6221.720022598994, 6227.439530442282, 6240.968795156041, 29699.10902672923, 30324.393512129634, 30337.938172163867, 30345.63444644974, 30360.0, 2244.9663255051187, 2277.1802151225547, 2280.201929324723, 2280.749117597063, 2283.5547068321684, 19838.70241946372, 20462.897685511627, 20532.38402847917, 20689.482762930897, 20706.79293207064, 2469.9012039518398, 2495.9376015599573, 2548.24826676131, 2576.2013775729583, 2583.5220484210295, 136313.0, 142584.287078565, 154652.0, 160765.19617401954, 161208.0, 15073.177540277435, 15600.92199538995, 16017.439389621308, 16628.418005369753, 16960.74558881618, 26039.73960260411, 26106.216813495244, 26106.216813495626, 26172.476550469266, 26201.379862013648, 10259.332573530935, 10300.948495257475, 10404.0, 10657.360558366523, 10723.731906702395, 9532.142107210384, 9583.904160958302, 9645.37305075168, 9648.614055437703, 9760.414375137372, 9628.229741620653, 9816.901830981742, 9857.507124643738, 9878.753031174278, 9893.307468477282, 2674.371522692166, 2713.1046754570943, 2722.387462820889, 2729.5223335916135, 2757.655293088364, 1033.751899544104, 1045.4511381524608, 1047.0471870597719, 1071.0681706914877, 1071.9892801072046, 20858.687119693215, 21613.459663508223, 21773.45566360822, 21800.34598962034, 21916.342509724735, 1119.5074167366333, 1120.1710734056903, 1122.8428020077197, 1131.7736452709491, 1133.659902029388, 11965.222260553037, 12181.512739490321, 12187.817182742267, 12229.633111006506, 12292.078094142975, 604023.0, 623894.0, 625849.0, 638665.0, 650817.0, 134417.0, 134983.3250833759, 138210.0, 139078.0, 139576.0, 1108.7172770943519, 1196.4615922834585, 1229.3115855120982, 1270.974580508403, 1292.2440372382073, 22699.0, 22939.54120917539, 22949.967251474056, 23191.304260871526, 23924.40188995289, 65310.0, 66209.66895165494, 69184.0, 70056.29943700497, 70637.64681176562, 82968.58515707383, 83424.58287708522, 84704.0, 85806.57096714477, 86473.56763216143, 21586.78413215848, 22058.33824985253, 22226.777732222472, 22256.109755609596, 22269.554608908056, 24480.75519244856, 24991.250262492154, 24991.500169996863, 25014.874925625983, 25116.62325065162, 16788.992660440414, 20007.59984800325, 20058.39824805258, 20200.0, 20278.59442811165, 17679.646407072043, 17822.732659010384, 18103.094845257947, 18591.16339764687, 18710.625787483903, 19637.70543441821, 19906.402807915787, 20868.95655217203, 20949.476263093544, 21009.369718908456, 21207.57584848325, 21265.57468850645, 21274.36176914695, 21520.56958860783, 21581.24465643695, 19652.213911443952, 19685.21259149618, 19842.60314793725, 19919.203231871143, 20107.798922010592], "value": 13166.243102679682, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1399.7200559888022, 1455.9708805823884, 1463.9560813175608, 1495.5289083938558, 1507.0505581483667, 16720.163991800408, 17407.3037078517, 17409.390671326506, 17431.128443577803, 17435.476935691935, 16907.577310567212, 16947.322107115702, 16956.74564881528, 17021.48935531936, 17062.232199551017, 2856.3715982483873, 2932.4183083870703, 2990.790644654875, 2992.7456166225898, 2995.850207489617, 2840.957385639217, 2869.397426540429, 2874.338902052529, 2874.3676391193903, 2891.4939885520057, 2848.5442329227326, 2874.310165560261, 2880.683124856264, 2881.942361152776, 2881.985590072057, 2805.6072149899032, 2836.2767494289033, 2850.6294181756343, 2876.6116574262414, 2881.9567706484418, 2825.3642930340716, 2829.264391258267, 2840.332521857362, 2870.9282267943468, 2871.7794937151625, 16609.33562657492, 16727.16364181798, 16924.238409271613, 16929.06890121055, 16950.49148525546, 8438.324934005264, 8779.604917778652, 8785.64857405703, 8785.692500762443, 8792.824143517159, 5406.729663516848, 5492.80775172871, 5575.4424557543925, 5643.040683083886, 5670.6030577859565, 2046.0, 2092.3199960012903, 2117.544727883512, 2155.1271734947372, 2164.967525487119, 31206.53190202149, 31529.36941261162, 31562.368752625047, 31563.52654710181, 31658.366832663447, 7352.522086064496, 7528.661210245552, 7544.132424771112, 7701.691932322757, 7729.6521656524465, 19835.30576429818, 19865.404037878885, 19877.900610496854, 19879.30422435208, 20015.399538013884, 8530.232279094787, 8696.260817830429, 8748.300135989106, 8760.780980475412, 8782.780430489289, 7852.371810255166, 7931.841363172704, 7932.167122452175, 8051.758447246592, 8060.113387527367, 5512.0, 5719.8856022880145, 5798.420157984167, 5834.737436815353, 5847.386024467455, 1548.41934274647, 1573.622330640661, 1589.3165938646262, 1731.5151757507665, 1761.3659082730208, 1005.6781829814389, 1005.8591797148405, 1006.411249419098, 1011.6964910526813, 1021.8927012663563, 9983.201343892617, 10032.448215348226, 10044.29689921713, 10149.898501014895, 10275.948620256851, 1051.5215576912487, 1070.6038765656756, 1081.0162751895737, 1083.2254937719567, 1087.1194332590626, 6323.0, 6363.013732871413, 6514.478841692653, 6523.575967562188, 6537.836554086186, 24847.5030499389, 24919.0, 25589.616155757678, 25604.0, 25780.742192577833, 25088.874555627106, 25192.622110668355, 25478.108266210966, 25502.872485637825, 25521.74478255231, 12275.263484190977, 12809.359532023362, 12812.295323757282, 12847.293398862965, 12925.612231633066, 9572.76068098303, 9622.759431014281, 9686.806263874823, 9688.32181747271, 9826.65606703762, 20676.896615516827, 20732.378028659165, 21075.367738967856, 21463.785362146802, 21638.134474620838, 21941.67087493721, 21988.0, 22145.446363841034, 22335.10659573599, 23137.190198342978, 11945.522179112739, 11956.76086478283, 12008.759824803281, 12027.518899244282, 12144.514219431123, 15344.386224550894, 15400.614984625474, 15460.84539154639, 15473.148976806384, 15559.766603501183, 12834.871651283367, 12922.806157907828, 12984.870151298366, 13103.344832758514, 13212.339383030618, 12126.75746485083, 12363.258204507398, 12537.561185358469, 12584.559540416041, 12769.808452873029, 11157.27477713946, 11288.830667539829, 11291.887081129084, 11304.208705390543, 11305.943470282926, 8878.73363799087, 8880.600372983103, 8917.643294268157, 8989.235914947041, 9015.0, 8726.82546349082, 8783.956080219557, 8806.955965220133, 8807.339449541181, 8849.778755531162], "value": 7502.030762552612, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [527.4729657641129, 569.0922977850329, 571.3771988532499, 571.645579740561, 585.6895845202042, 6188.195534580504, 6275.309715931256, 6290.119383286338, 6311.999999999988, 6379.5853269537565, 6201.255849298079, 6202.751889924409, 6221.564490485668, 6288.968555157217, 6305.495560355172, 5180.171172612383, 5193.662411943231, 5218.425973142951, 5223.817166399177, 5232.45059268777, 4925.458199598042, 5194.55846253067, 5213.113770658997, 5222.764975576109, 5247.763850626731, 4985.252212168168, 5028.145215313405, 5030.798768049273, 5043.773030213631, 5049.520295571915, 5003.923371800698, 5020.523050310215, 5038.773255203525, 5041.8487445376695, 5053.848384548451, 4483.663725220622, 4533.954660453419, 4562.270036794097, 4579.496255411902, 4606.769661516911, 6081.726322315506, 6148.754049838001, 6168.506519478476, 6172.290186628506, 6205.441510264098, 5875.472377181921, 5903.557233207526, 5953.3451320354725, 5962.403759624046, 5970.432808883149, 6739.460843132538, 6752.5948443093575, 6761.3238676132, 6773.932260677379, 6789.864202715968, 5143.228515722634, 5146.768395422215, 5150.510701483353, 5174.327337446108, 5182.170852663593, 6761.830954226184, 6820.93179068208, 6961.756338528178, 6992.720291188346, 7014.333638304353, 5241.816536421207, 5246.160614301693, 5260.395054568697, 5276.261323414725, 5282.4717528246865, 5320.0, 5324.1747529133045, 5350.3312085989255, 5351.919721204185, 5368.812091576776, 5838.868812883267, 5879.559033072536, 5961.344252132262, 5963.612365196248, 6000.0, 6655.600663960178, 6696.363845434676, 6792.252852186256, 6795.728170873209, 6803.625800581016, 1835.68748344934, 1842.7788665360242, 1844.588889499507, 1848.879822811513, 1880.6614809334178, 1280.8920283954312, 1316.1182008054627, 1317.960461186166, 1329.6144118205805, 1339.8593147719544, 6121.408433807153, 6164.383561643889, 6214.285357183981, 6222.719977601018, 6274.843128921722, 6643.2028156620545, 6701.865962680817, 6722.025306330653, 6729.8654026919185, 6809.693563789641, 6144.754209831646, 6167.691615419211, 6189.690515474298, 6190.659513726789, 6235.971064774261, 3500.579930408367, 3561.216532362876, 3598.8200589970397, 3611.638836116367, 3611.819409029538, 6971.163460384786, 7054.365107140382, 7072.762266603324, 7113.146422429341, 7144.0, 6909.827254318682, 6912.55068420551, 6922.5154239202775, 7089.151450053726, 7100.4319654428555, 7023.508354415244, 7028.1375435509635, 7099.787006389816, 7108.573485590881, 7187.96406017977, 6661.16735408074, 6744.258131605421, 6750.696218670073, 6767.526273160832, 6779.254282029072, 6665.933450647873, 6673.699683514351, 6687.1975362956755, 6705.564138330993, 6730.798076057726, 7005.579665220103, 7027.332403421667, 7030.156381234285, 7051.682674279567, 7065.929340706733, 5218.791248350175, 5223.425423203521, 5249.632525723163, 5289.391719952255, 5299.178627312773, 6553.5084868634085, 6622.90065649006, 6665.700043498151, 6676.563054485175, 6691.2639609643875, 6507.577007494498, 6542.705578249085, 6547.672616369257, 6562.3109573496, 6624.271330153776, 6423.775167869102, 6448.258450278278, 6547.148870646785, 6624.966875165594, 6676.432503237279, 6489.318621544669, 6500.122483464672, 6553.311902250386, 6566.507511936528, 6586.485108425185, 6594.790745100445, 6650.800475985729, 6651.401373876374, 6673.798716231125, 6714.3549830291895, 6439.83900402475, 6450.161479007699, 6466.0925027118055, 6475.931471307182, 6540.967295163684], "value": 5226.8919167853755, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [978.8531720241967, 995.0298459002473, 998.6354980432139, 1003.6437064841986, 1014.4978235773291, 23200.187993420233, 24914.999999999978, 25124.87437562812, 25125.120620778278, 25155.62266566003, 22151.778482215173, 22689.432764180863, 22847.42881427965, 22899.198528051522, 22902.770972290273, 1058.8041212375715, 1087.3475914451305, 1089.6622047165365, 1090.2858627598935, 1091.0889407344876, 1025.8615086963239, 1072.1851392941383, 1074.4949873559415, 1075.3010543146977, 1077.0468135699923, 1139.880312567181, 1139.903108235801, 1140.1278022312895, 1140.4297851074464, 1140.8402823604702, 1128.8758236594051, 1133.4162906103322, 1134.160721066413, 1135.1429670598727, 1137.1357768096223, 836.6569706420399, 839.1482645115213, 839.9748007559783, 840.2143995364293, 842.6713581703141, 19153.799319286558, 19487.415377538695, 19508.90245548763, 19588.804111958983, 21251.0, 23205.187818426275, 23586.17448389315, 23782.7621723784, 23794.40513987164, 23827.0, 17599.0, 17737.219369075443, 17809.109544522853, 17825.643487130186, 17902.91048544762, 3844.3272427325105, 4009.258287216845, 4026.7382620129597, 4031.21391328691, 4044.4539987101953, 155693.22153389273, 158257.0, 158748.20625896796, 160259.0, 160282.1985890075, 17218.536424404065, 17298.481045568653, 17593.120343983006, 17751.289948402176, 17852.107394630475, 33459.66540334614, 33671.15822104418, 33718.15704607355, 33776.83111584427, 33883.491747623804, 9361.0, 9383.483908385104, 9416.05839416053, 9434.95282523583, 9435.150836424755, 4780.856574302707, 4950.133726597831, 4971.204607262821, 4982.177940639826, 5015.122353588107, 6254.749810007549, 6361.14124593174, 6375.808725738235, 6406.135171751847, 6410.326915673787, 1112.67732357617, 1113.0872684398878, 1118.7874303882236, 1122.2985633978763, 1132.3828513460185, 704.968276427562, 708.2351060854265, 713.2261496276598, 719.3238355945394, 725.5066554742825, 12823.0, 13232.73534529304, 13373.197608143542, 14214.360353784105, 14231.07498012626, 739.8298391370015, 741.4476215219696, 744.7058411927259, 746.1941103608091, 766.3715753082419, 6024.3975602439405, 6036.969815150984, 6106.389361063858, 6129.908051379233, 6174.104754810527, 143241.28379358244, 143361.0, 144782.0, 145921.0, 146445.0, 127412.36293818471, 128245.0, 128939.0, 129493.0, 131029.34485327703, 108762.45618771855, 110379.0, 111755.0, 112548.0, 113915.4304228457, 11711.121665874924, 11862.169648124893, 11907.404629768651, 11916.52333906634, 11945.402729863647, 53534.0, 53615.463845361046, 53798.46201538091, 54607.0, 55176.44823551713, 69130.65434672794, 70820.0, 70990.64504677443, 71066.64466677634, 74404.2559574419, 15519.689606208038, 15796.21018949071, 15816.446424375092, 15853.048817071012, 15857.048577085412, 18205.0, 18241.908790455964, 18263.54341141482, 18343.54141146482, 18506.629867402306, 17296.135193240538, 17526.0, 17562.20970056325, 17688.204030818386, 17740.11299435049, 15574.688506229586, 15620.765688514908, 15785.763213552036, 15849.0, 15910.681786363977, 16978.66042679164, 17230.05234712103, 17349.479515614552, 17537.91231043888, 17628.1185940705, 12983.675408114872, 13463.326833658082, 13608.455661773814, 13623.79564306556, 13641.38613762403, 13233.933830330787, 13359.26524041187, 13389.393272807325, 13420.0, 13439.328033598085], "value": 9925.892082988732, "unit": "score"}]}, {"extraOptions": ["e10s", "stylo_disabled"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1375.1999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 104.0, 105.0, 106.0, 105.0, 107.0, 112.0, 106.0, 103.0, 105.0], "value": 105.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 114.0, 116.0, 115.0, 116.0, 115.0, 115.0, 146.0, 118.0, 113.0], "value": 118.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 162.0, 163.0, 161.0, 161.0, 162.0, 161.0, 160.0, 162.0, 164.0], "value": 161.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 74.0, 74.0, 73.0, 74.0, 74.0, 74.0, 76.0, 74.0, 75.0], "value": 74.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 78.0, 79.0, 77.0, 78.0, 77.0, 79.0, 79.0, 78.0, 79.0], "value": 78.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 110.0, 114.0, 114.0, 113.0, 110.0, 114.0, 112.0, 115.0], "value": 113.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 150.0, 149.0, 151.0, 150.0, 150.0, 150.0, 154.0, 150.0, 150.0], "value": 150.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 95.0, 93.0, 100.0, 100.0, 96.0, 95.0, 100.0, 95.0], "value": 96.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [48.0, 43.0, 46.0, 44.0, 45.0, 45.0, 46.0, 44.0, 44.0, 44.0], "value": 44.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [35.0, 36.0, 36.0, 36.0, 35.0, 37.0, 36.0, 37.0, 36.0, 36.0], "value": 36.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 73.0, 73.0, 72.0, 73.0, 75.0, 76.0, 71.0, 72.0, 71.0], "value": 72.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 111.0, 103.0, 107.0, 107.0, 110.0, 105.0, 119.0, 105.0, 103.0], "value": 107.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 162.0, 152.0, 150.0, 164.0, 155.0, 153.0, 155.0, 161.0, 150.0], "value": 155.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 60.0, 59.0, 59.0, 60.0, 64.0, 58.0, 58.0, 59.0, 61.0], "value": 59.8, "unit": "score"}]}]} 19:01:51 INFO - Return code: 0 19:01:51 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 19:01:51 INFO - # TBPL SUCCESS # 19:01:51 INFO - Running post-action listener: _package_coverage_data 19:01:51 INFO - Running post-action listener: _resource_record_post_action 19:01:51 INFO - [mozharness: 2017-09-27 02:01:51.247505Z] Finished run-tests step (success) 19:01:51 INFO - Running post-run listener: _resource_record_post_run 19:01:51 INFO - Total resource usage - Wall time: 1186s; CPU: 13.0%; Read bytes: 12288; Write bytes: 334594048; Read time: 452; Write time: 366932 19:01:51 INFO - TinderboxPrint: CPU usage
13.1% 19:01:51 INFO - TinderboxPrint: I/O read bytes / time
12,288 / 452 19:01:51 INFO - TinderboxPrint: I/O write bytes / time
334,594,048 / 366,932 19:01:51 INFO - TinderboxPrint: CPU idle
8,216.8 (86.9%) 19:01:51 INFO - TinderboxPrint: CPU user
1,187.7 (12.6%) 19:01:51 INFO - TinderboxPrint: Swap in / out
0 / 0 19:01:51 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 13651968; Read time: 0; Write time: 4884 19:01:51 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 19:01:51 INFO - run-tests - Wall time: 1169s; CPU: 13.0%; Read bytes: 12288; Write bytes: 320532480; Read time: 452; Write time: 362020 19:01:51 INFO - Running post-run listener: _upload_blobber_files 19:01:51 INFO - Blob upload gear active. 19:01:51 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:01:51 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 19:01:51 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'] 19:01:51 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 19:01:52 INFO - (blobuploader) - INFO - Open directory for files ... 19:01:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 19:01:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:01:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:01:53 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 19:01:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:01:53 INFO - (blobuploader) - INFO - Done attempting. 19:01:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 19:01:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:01:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:02:01 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 19:02:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:02:01 INFO - (blobuploader) - INFO - Done attempting. 19:02:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log ... 19:02:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:02:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:02:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_raw.log: uploaded 19:02:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:02:02 INFO - (blobuploader) - INFO - Done attempting. 19:02:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log ... 19:02:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:02:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:02:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_errorsummary.log: uploaded 19:02:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:02:03 INFO - (blobuploader) - INFO - Done attempting. 19:02:03 INFO - (blobuploader) - INFO - Iteration through files over. 19:02:03 INFO - Return code: 0 19:02:03 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:02:03 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:02:03 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d7b1b7190c3b0605608718d8ca51eb19970decb1b2ff3a11e40de5e8bfab34df7c6f4b54cdc0fd48a8bd46bcec154ebee5d3d41bcc095f83c61e1aacbc59c571", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1586d3bf1f4aa01727c651e2124f57d9fc1e4588913c1b40923a671792d70577610da554857f535b80eaf5e707716c4d7a969c3f80b2e31752976b6327811a3a", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a8e8e713066462b36a72dc1dc05ea990145689cca876b82028da156ccc4b69fbfc0a11ad063852c9caed152432fc49b99e1a533a2ecfb6fd46db134bff785590", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/09b2f59e67a0f4f2a1444c680a6d6fb55ddb20e973f54f8cc91f25f4d044ad2733176e707912519d29f486d52db0f5ba7c0bb39517bf1c5674b4e4f3f8ffd356"} 19:02:03 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:02:03 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:02:03 INFO - Contents: 19:02:03 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d7b1b7190c3b0605608718d8ca51eb19970decb1b2ff3a11e40de5e8bfab34df7c6f4b54cdc0fd48a8bd46bcec154ebee5d3d41bcc095f83c61e1aacbc59c571", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1586d3bf1f4aa01727c651e2124f57d9fc1e4588913c1b40923a671792d70577610da554857f535b80eaf5e707716c4d7a969c3f80b2e31752976b6327811a3a", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a8e8e713066462b36a72dc1dc05ea990145689cca876b82028da156ccc4b69fbfc0a11ad063852c9caed152432fc49b99e1a533a2ecfb6fd46db134bff785590", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/09b2f59e67a0f4f2a1444c680a6d6fb55ddb20e973f54f8cc91f25f4d044ad2733176e707912519d29f486d52db0f5ba7c0bb39517bf1c5674b4e4f3f8ffd356"} 19:02:03 INFO - Running post-run listener: copy_logs_to_upload_dir 19:02:03 INFO - Copying logs to upload dir... 19:02:03 INFO - mkdir: /builds/slave/test/build/upload/logs 19:02:03 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1244.365142 ========= master_lag: -0.39 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2017-09-26 19:02:02.914255) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-26 19:02:02.919200) ========= 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=df17445c3590ff7897617a0e00000225-1506475638.995008-257981642 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d7b1b7190c3b0605608718d8ca51eb19970decb1b2ff3a11e40de5e8bfab34df7c6f4b54cdc0fd48a8bd46bcec154ebee5d3d41bcc095f83c61e1aacbc59c571", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1586d3bf1f4aa01727c651e2124f57d9fc1e4588913c1b40923a671792d70577610da554857f535b80eaf5e707716c4d7a969c3f80b2e31752976b6327811a3a", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a8e8e713066462b36a72dc1dc05ea990145689cca876b82028da156ccc4b69fbfc0a11ad063852c9caed152432fc49b99e1a533a2ecfb6fd46db134bff785590", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/09b2f59e67a0f4f2a1444c680a6d6fb55ddb20e973f54f8cc91f25f4d044ad2733176e707912519d29f486d52db0f5ba7c0bb39517bf1c5674b4e4f3f8ffd356"} build_url:https://queue.taskcluster.net/v1/task/ViBZ0mWEQlOae9cmg2YqOQ/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011279 build_url: 'https://queue.taskcluster.net/v1/task/ViBZ0mWEQlOae9cmg2YqOQ/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d7b1b7190c3b0605608718d8ca51eb19970decb1b2ff3a11e40de5e8bfab34df7c6f4b54cdc0fd48a8bd46bcec154ebee5d3d41bcc095f83c61e1aacbc59c571", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1586d3bf1f4aa01727c651e2124f57d9fc1e4588913c1b40923a671792d70577610da554857f535b80eaf5e707716c4d7a969c3f80b2e31752976b6327811a3a", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a8e8e713066462b36a72dc1dc05ea990145689cca876b82028da156ccc4b69fbfc0a11ad063852c9caed152432fc49b99e1a533a2ecfb6fd46db134bff785590", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/09b2f59e67a0f4f2a1444c680a6d6fb55ddb20e973f54f8cc91f25f4d044ad2733176e707912519d29f486d52db0f5ba7c0bb39517bf1c5674b4e4f3f8ffd356"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-26 19:02:02.949705) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-26 19:02:02.950239) ========= 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=df17445c3590ff7897617a0e00000225-1506475638.995008-257981642 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004487 ========= master_lag: 0.07 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-26 19:02:03.029614) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-26 19:02:03.029935) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-26 19:02:03.030253) ========= ========= Total master_lag: -0.21 =========