builder: mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s slave: talos-linux64-ix-071 starttime: 1500718140.84 results: success (0) revision: 7e496e6bac00d2acbf3dcd5615c13d4ac489724e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-07-22 03:09:00.843127) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-07-22 03:09:00.843548) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-07-22 03:09:00.843825) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-07-22 03:09:00.898620) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-22 03:09:00.898878) ========= 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=dbb0bb31bf4a4c7db9ba1648000001b6-1500696907.17719-1539955509 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-07-22 03:09:01-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.2M=0s 2017-07-22 03:09:01 (46.2 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.180727 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-22 03:09:01.112947) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-07-22 03:09:01.113371) ========= 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=dbb0bb31bf4a4c7db9ba1648000001b6-1500696907.17719-1539955509 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021976 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-07-22 03:09:01.162483) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-22 03:09:01.162774) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 7e496e6bac00d2acbf3dcd5615c13d4ac489724e --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 7e496e6bac00d2acbf3dcd5615c13d4ac489724e --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=dbb0bb31bf4a4c7db9ba1648000001b6-1500696907.17719-1539955509 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-07-22 03:09:01,738 truncating revision to first 12 chars 2017-07-22 03:09:01,738 Setting DEBUG logging. 2017-07-22 03:09:01,738 attempt 1/10 2017-07-22 03:09:01,738 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/7e496e6bac00?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-07-22 03:09:02,249 unpacking tar archive at: mozilla-central-7e496e6bac00/testing/mozharness/ program finished with exit code 0 elapsedTime=0.830870 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-22 03:09:02.025355) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-07-22 03:09:02.025623) ========= script_repo_revision: 7e496e6bac00d2acbf3dcd5615c13d4ac489724e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-07-22 03:09:02.025990) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-07-22 03:09:02.026265) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-07-22 03:09:02.083105) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 29 secs) (at 2017-07-22 03:09:02.083409) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=dbb0bb31bf4a4c7db9ba1648000001b6-1500696907.17719-1539955509 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:09:02 INFO - MultiFileLogger online at 20170722 03:09:02 in /builds/slave/test 03:09:02 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 03:09:02 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:09:02 INFO - {'append_to_log': False, 03:09:02 INFO - 'base_work_dir': '/builds/slave/test', 03:09:02 INFO - 'blob_upload_branch': 'Firefox', 03:09:02 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:09:02 INFO - 'branch': 'Firefox', 03:09:02 INFO - 'buildbot_json_path': 'buildprops.json', 03:09:02 INFO - 'code_coverage': False, 03:09:02 INFO - 'config_files': ('talos/linux_config.py',), 03:09:02 INFO - 'default_actions': ('clobber', 03:09:02 INFO - 'read-buildbot-config', 03:09:02 INFO - 'download-and-extract', 03:09:02 INFO - 'populate-webroot', 03:09:02 INFO - 'create-virtualenv', 03:09:02 INFO - 'install', 03:09:02 INFO - 'setup-mitmproxy', 03:09:02 INFO - 'run-tests'), 03:09:02 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:09:02 INFO - 'disable_ccov_upload': False, 03:09:02 INFO - 'download_minidump_stackwalk': True, 03:09:02 INFO - 'download_symbols': 'ondemand', 03:09:02 INFO - 'enable_stylo': False, 03:09:02 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:09:02 INFO - 'tooltool.py': '/tools/tooltool.py', 03:09:02 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:09:02 INFO - '/tools/misc-python/virtualenv.py')}, 03:09:02 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:09:02 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:09:02 INFO - 'gecko_profile': False, 03:09:02 INFO - 'gecko_profile_interval': 0, 03:09:02 INFO - 'installer_path': 'installer.exe', 03:09:02 INFO - 'log_level': 'info', 03:09:02 INFO - 'log_name': 'talos', 03:09:02 INFO - 'log_to_console': True, 03:09:02 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:09:02 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:09:02 INFO - 'opt_config_files': (), 03:09:02 INFO - 'pip_index': False, 03:09:02 INFO - 'suite': 'dromaeojs-e10s', 03:09:02 INFO - 'system_bits': '32', 03:09:02 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:09:02 INFO - 'title': 'talos-linux64-ix-071', 03:09:02 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:09:02 INFO - 'use_talos_json': True, 03:09:02 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:09:02 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:09:02 INFO - 'work_dir': 'build'} 03:09:02 INFO - [mozharness: 2017-07-22 10:09:02.857945Z] Running clobber step. 03:09:02 INFO - Running pre-action listener: _resource_record_pre_action 03:09:02 INFO - Running main action method: clobber 03:09:02 INFO - rmtree: /builds/slave/test/build 03:09:02 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:09:03 INFO - Running post-action listener: _resource_record_post_action 03:09:03 INFO - [mozharness: 2017-07-22 10:09:03.833855Z] Finished clobber step (success) 03:09:03 INFO - [mozharness: 2017-07-22 10:09:03.833957Z] Running read-buildbot-config step. 03:09:03 INFO - Running pre-action listener: _resource_record_pre_action 03:09:03 INFO - Running main action method: read_buildbot_config 03:09:03 INFO - Using buildbot properties: 03:09:03 INFO - { 03:09:03 INFO - "project": "", 03:09:03 INFO - "product": "firefox", 03:09:03 INFO - "who": "archaeopteryx@coole-files.de", 03:09:03 INFO - "installer_path": "public/build/target.tar.bz2", 03:09:03 INFO - "builddir": "mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s", 03:09:03 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 03:09:03 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo-sequential mozilla-central talos dromaeojs-e10s", 03:09:03 INFO - "stage_platform": "linux64-stylosequential", 03:09:03 INFO - "basedir": "/builds/slave/test", 03:09:03 INFO - "buildnumber": 115, 03:09:03 INFO - "platform": "ubuntu64_hw_styloseq", 03:09:03 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 03:09:03 INFO - "slavebuilddir": "test", 03:09:03 INFO - "taskId": "O78ANiLGTzGepgorBg1dZg", 03:09:03 INFO - "branch": "mozilla-central", 03:09:03 INFO - "script_repo_revision": "production", 03:09:03 INFO - "revision": "7e496e6bac00d2acbf3dcd5615c13d4ac489724e", 03:09:03 INFO - "slavename": "talos-linux64-ix-071", 03:09:03 INFO - "repo_path": "mozilla-central" 03:09:03 INFO - } 03:09:03 INFO - Finding installer, test and symbols from parent task. 03:09:03 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/O78ANiLGTzGepgorBg1dZg'}, attempt #1 03:09:04 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/O78ANiLGTzGepgorBg1dZg'}, attempt #1 03:09:04 INFO - Task dependencies: FpuMD3hSStKv4jAqluX4GQ 03:09:04 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FpuMD3hSStKv4jAqluX4GQ'}, attempt #1 03:09:05 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/FpuMD3hSStKv4jAqluX4GQ/artifacts/public/build/target.tar.bz2 03:09:05 INFO - Set test_url: https://queue.taskcluster.net/v1/task/FpuMD3hSStKv4jAqluX4GQ/artifacts/public/build/test_packages.json 03:09:05 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/FpuMD3hSStKv4jAqluX4GQ/artifacts/public/build/target.crashreporter-symbols.zip 03:09:05 INFO - Running post-action listener: _resource_record_post_action 03:09:05 INFO - [mozharness: 2017-07-22 10:09:05.154088Z] Finished read-buildbot-config step (success) 03:09:05 INFO - [mozharness: 2017-07-22 10:09:05.154313Z] Running download-and-extract step. 03:09:05 INFO - Running pre-action listener: _resource_record_pre_action 03:09:05 INFO - Running main action method: download_and_extract 03:09:05 INFO - mkdir: /builds/slave/test/build/tests 03:09:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:09:05 INFO - trying https://queue.taskcluster.net/v1/task/FpuMD3hSStKv4jAqluX4GQ/artifacts/public/build/target.test_packages.json 03:09:05 INFO - Downloading https://queue.taskcluster.net/v1/task/FpuMD3hSStKv4jAqluX4GQ/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 03:09:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FpuMD3hSStKv4jAqluX4GQ/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 03:09:05 INFO - Downloaded 989 bytes. 03:09:05 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 03:09:05 INFO - Using the following test package requirements: 03:09:05 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 03:09:05 INFO - u'common': [u'target.common.tests.zip'], 03:09:05 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 03:09:05 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 03:09:05 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 03:09:05 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 03:09:05 INFO - u'mozbase': [u'target.common.tests.zip'], 03:09:05 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 03:09:05 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 03:09:05 INFO - u'web-platform': [u'target.common.tests.zip', 03:09:05 INFO - u'target.web-platform.tests.tar.gz'], 03:09:05 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 03:09:05 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 03:09:05 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/FpuMD3hSStKv4jAqluX4GQ/artifacts/public/build/target.common.tests.zip 03:09:05 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/FpuMD3hSStKv4jAqluX4GQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 03:09:05 INFO - Fetch https://queue.taskcluster.net/v1/task/FpuMD3hSStKv4jAqluX4GQ/artifacts/public/build/target.common.tests.zip into memory 03:09:08 INFO - Content-Length response header: 72760714 03:09:08 INFO - Bytes received: 72760714 03:09:19 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 03:09:19 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/FpuMD3hSStKv4jAqluX4GQ/artifacts/public/build/target.common.tests.zip 03:09:19 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/FpuMD3hSStKv4jAqluX4GQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 03:09:19 INFO - Fetch https://queue.taskcluster.net/v1/task/FpuMD3hSStKv4jAqluX4GQ/artifacts/public/build/target.common.tests.zip into memory 03:09:21 INFO - Content-Length response header: 72760714 03:09:21 INFO - Bytes received: 72760714 03:09:34 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/FpuMD3hSStKv4jAqluX4GQ/artifacts/public/build/target.talos.tests.zip 03:09:34 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/FpuMD3hSStKv4jAqluX4GQ/artifacts/public/build/target.talos.tests.zip'}, attempt #1 03:09:34 INFO - Fetch https://queue.taskcluster.net/v1/task/FpuMD3hSStKv4jAqluX4GQ/artifacts/public/build/target.talos.tests.zip into memory 03:09:34 INFO - retry: attempt #1 caught HTTPError exception: HTTP Error 500: Internal Server Error 03:09:34 INFO - retry: Failed, sleeping 30 seconds before retrying 03:10:04 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/FpuMD3hSStKv4jAqluX4GQ/artifacts/public/build/target.talos.tests.zip'}, attempt #2 03:10:04 INFO - Fetch https://queue.taskcluster.net/v1/task/FpuMD3hSStKv4jAqluX4GQ/artifacts/public/build/target.talos.tests.zip into memory 03:10:05 INFO - Content-Length response header: 14498971 03:10:05 INFO - Bytes received: 14498971 03:10:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:10:05 INFO - trying https://queue.taskcluster.net/v1/task/FpuMD3hSStKv4jAqluX4GQ/artifacts/public/build/target.tar.bz2 03:10:05 INFO - Downloading https://queue.taskcluster.net/v1/task/FpuMD3hSStKv4jAqluX4GQ/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 03:10:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FpuMD3hSStKv4jAqluX4GQ/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 03:10:06 INFO - Downloaded 62105830 bytes. 03:10:06 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/FpuMD3hSStKv4jAqluX4GQ/artifacts/public/build/target.tar.bz2 03:10:06 INFO - mkdir: /builds/slave/test/properties 03:10:06 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:10:06 INFO - Writing to file /builds/slave/test/properties/build_url 03:10:06 INFO - Contents: 03:10:06 INFO - build_url:https://queue.taskcluster.net/v1/task/FpuMD3hSStKv4jAqluX4GQ/artifacts/public/build/target.tar.bz2 03:10:06 INFO - Running post-action listener: _resource_record_post_action 03:10:06 INFO - Running post-action listener: set_extra_try_arguments 03:10:06 INFO - [mozharness: 2017-07-22 10:10:06.592731Z] Finished download-and-extract step (success) 03:10:06 INFO - [mozharness: 2017-07-22 10:10:06.592829Z] Running populate-webroot step. 03:10:06 INFO - Running pre-action listener: _resource_record_pre_action 03:10:06 INFO - Running main action method: populate_webroot 03:10:06 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:10:06 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:10:06 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:10:06 INFO - '--tppagecycles', 03:10:06 INFO - '7'], 03:10:06 INFO - 'tests': ['tsvgm']}}, 03:10:06 INFO - 'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:10:06 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:10:06 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:10:06 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:10:06 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 03:10:06 INFO - 'talos_options': ['--disable-e10s'], 03:10:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:10:06 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 03:10:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:10:06 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 03:10:06 INFO - 'talos_options': ['--disable-e10s'], 03:10:06 INFO - 'tests': ['damp', 'tps']}, 03:10:06 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 03:10:06 INFO - 'tests': ['damp', 'tps']}, 03:10:06 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:10:06 INFO - 'tests': ['dromaeo_dom']}, 03:10:06 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:10:06 INFO - 'g4': {'talos_options': ['--disable-e10s'], 03:10:06 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 03:10:06 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 03:10:06 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 03:10:06 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 03:10:06 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:10:06 INFO - 'tests': ['a11yr', 03:10:06 INFO - 'ts_paint', 03:10:06 INFO - 'tpaint', 03:10:06 INFO - 'sessionrestore', 03:10:06 INFO - 'sessionrestore_no_auto_restore', 03:10:06 INFO - 'tabpaint']}, 03:10:06 INFO - 'other-e10s': {'tests': ['a11yr', 03:10:06 INFO - 'ts_paint', 03:10:06 INFO - 'tpaint', 03:10:06 INFO - 'sessionrestore', 03:10:06 INFO - 'sessionrestore_many_windows', 03:10:06 INFO - 'sessionrestore_no_auto_restore', 03:10:06 INFO - 'tabpaint']}, 03:10:06 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:10:06 INFO - 'ts_paint', 03:10:06 INFO - 'tpaint', 03:10:06 INFO - 'sessionrestore', 03:10:06 INFO - 'sessionrestore_many_windows', 03:10:06 INFO - 'sessionrestore_no_auto_restore', 03:10:06 INFO - 'tabpaint']}, 03:10:06 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:10:06 INFO - 'ts_paint', 03:10:06 INFO - 'tpaint', 03:10:06 INFO - 'sessionrestore', 03:10:06 INFO - 'sessionrestore_many_windows', 03:10:06 INFO - 'sessionrestore_no_auto_restore', 03:10:06 INFO - 'tabpaint']}, 03:10:06 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:10:06 INFO - 'tests': ['a11yr', 03:10:06 INFO - 'ts_paint', 03:10:06 INFO - 'tpaint', 03:10:06 INFO - 'sessionrestore', 03:10:06 INFO - 'sessionrestore_no_auto_restore', 03:10:06 INFO - 'tabpaint']}, 03:10:06 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:10:06 INFO - 'tests': ['a11yr', 03:10:06 INFO - 'ts_paint', 03:10:06 INFO - 'tpaint', 03:10:06 INFO - 'sessionrestore', 03:10:06 INFO - 'sessionrestore_no_auto_restore', 03:10:06 INFO - 'tabpaint']}, 03:10:06 INFO - 'perf-reftest': {'tests': ['bloom_basic']}, 03:10:06 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 03:10:06 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 03:10:06 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:10:06 INFO - 'talos_options': ['--mitmproxy', 03:10:06 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:10:06 INFO - '--firstNonBlankPaint'], 03:10:06 INFO - 'tests': ['quantum_pageload_google', 03:10:06 INFO - 'quantum_pageload_youtube', 03:10:06 INFO - 'quantum_pageload_amazon', 03:10:06 INFO - 'quantum_pageload_facebook']}, 03:10:06 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:10:06 INFO - 'tests': ['tsvgx', 03:10:06 INFO - 'tsvgr_opacity', 03:10:06 INFO - 'tart', 03:10:06 INFO - 'tscrollx', 03:10:06 INFO - 'cart', 03:10:06 INFO - 'tsvg_static']}, 03:10:06 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:10:06 INFO - 'tsvgr_opacity', 03:10:06 INFO - 'tart', 03:10:06 INFO - 'tscrollx', 03:10:06 INFO - 'cart', 03:10:06 INFO - 'tsvg_static']}, 03:10:06 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 03:10:06 INFO - 'talos_options': ['--disable-e10s'], 03:10:06 INFO - 'tests': ['tp5o']}, 03:10:06 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 03:10:06 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 03:10:06 INFO - 'talos_options': ['--disable-e10s', 03:10:06 INFO - '--xperf_path', 03:10:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:10:06 INFO - 'tests': ['tp5n']}, 03:10:06 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 03:10:06 INFO - 'talos_options': ['--xperf_path', 03:10:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:10:06 INFO - 'tests': ['tp5n']}}, 03:10:06 INFO - 'talos.zip': {'path': '', 03:10:06 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:10:06 INFO - Running post-action listener: _resource_record_post_action 03:10:06 INFO - [mozharness: 2017-07-22 10:10:06.608218Z] Finished populate-webroot step (success) 03:10:06 INFO - [mozharness: 2017-07-22 10:10:06.608308Z] Running create-virtualenv step. 03:10:06 INFO - Running pre-action listener: _resource_record_pre_action 03:10:06 INFO - Running main action method: create_virtualenv 03:10:06 INFO - Creating virtualenv /builds/slave/test/build/venv 03:10:06 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 03:10:06 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:10:06 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 03:10:06 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:10:06 INFO - Using real prefix '/usr' 03:10:06 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:10:07 INFO - Installing distribute.............................................................................................................................................................................................done. 03:10:09 INFO - Installing pip.................done. 03:10:09 INFO - Return code: 0 03:10:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 03:10:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 03:10:09 INFO - Reading from file tmpfile_stdout 03:10:09 INFO - Output received: 03:10:09 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 03:10:09 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:10:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:10:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:10:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:10:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:10:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf9c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1168a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x130bd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1308eb0>, '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 0x1309db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x130a240>, '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': 'dbb0bb31bf4a4c7db9ba1648000001b6-1500696907.17719-1539955509', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:10:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 03:10:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 03:10:09 INFO - Using env: {'DISPLAY': ':0', 03:10:09 INFO - 'HOME': '/home/cltbld', 03:10:09 INFO - 'LANG': 'en_US.UTF-8', 03:10:09 INFO - 'LANGUAGE': 'en_US:en', 03:10:09 INFO - 'LOGNAME': 'cltbld', 03:10:09 INFO - 'MAIL': '/var/mail/cltbld', 03:10:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:10:09 INFO - 'MOZ_NO_REMOTE': '1', 03:10:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:10:09 INFO - 'NO_EM_RESTART': '1', 03:10:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:10:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:10:09 INFO - 'PWD': '/builds/slave/test', 03:10:09 INFO - 'SHELL': '/bin/bash', 03:10:09 INFO - 'SHLVL': '1', 03:10:09 INFO - 'TERM': 'linux', 03:10:09 INFO - 'TMOUT': '86400', 03:10:09 INFO - 'USER': 'cltbld', 03:10:09 INFO - 'XDG_SESSION_COOKIE': 'dbb0bb31bf4a4c7db9ba1648000001b6-1500696907.17719-1539955509', 03:10:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:10:09 INFO - '_': '/tools/buildbot/bin/python'} 03:10:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:10:09 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 03:10:09 INFO - Cleaning up... 03:10:09 INFO - Return code: 0 03:10:09 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:10:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:10:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:10:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:10:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:10:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xf9c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1168a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x130bd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1308eb0>, '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 0x1309db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x130a240>, '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': 'dbb0bb31bf4a4c7db9ba1648000001b6-1500696907.17719-1539955509', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:10:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 03:10:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 03:10:09 INFO - Using env: {'DISPLAY': ':0', 03:10:09 INFO - 'HOME': '/home/cltbld', 03:10:09 INFO - 'LANG': 'en_US.UTF-8', 03:10:09 INFO - 'LANGUAGE': 'en_US:en', 03:10:09 INFO - 'LOGNAME': 'cltbld', 03:10:09 INFO - 'MAIL': '/var/mail/cltbld', 03:10:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:10:09 INFO - 'MOZ_NO_REMOTE': '1', 03:10:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:10:09 INFO - 'NO_EM_RESTART': '1', 03:10:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:10:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:10:09 INFO - 'PWD': '/builds/slave/test', 03:10:09 INFO - 'SHELL': '/bin/bash', 03:10:09 INFO - 'SHLVL': '1', 03:10:09 INFO - 'TERM': 'linux', 03:10:09 INFO - 'TMOUT': '86400', 03:10:09 INFO - 'USER': 'cltbld', 03:10:09 INFO - 'XDG_SESSION_COOKIE': 'dbb0bb31bf4a4c7db9ba1648000001b6-1500696907.17719-1539955509', 03:10:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:10:09 INFO - '_': '/tools/buildbot/bin/python'} 03:10:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:10:10 INFO - Downloading/unpacking psutil>=3.1.1 03:10:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:10:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:10:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:10:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:10:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:10:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:10:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:10:11 INFO - Installing collected packages: psutil 03:10:11 INFO - Running setup.py install for psutil 03:10:11 INFO - building 'psutil._psutil_linux' extension 03:10:11 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 03:10:12 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 03:10:12 INFO - building 'psutil._psutil_posix' extension 03:10:12 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 03:10:12 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 03:10:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:10:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:10:12 INFO - Successfully installed psutil 03:10:12 INFO - Cleaning up... 03:10:12 INFO - Return code: 0 03:10:12 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:10:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:10:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:10:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:10:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:10:12 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 0xf9c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1168a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x130bd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1308eb0>, '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 0x1309db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x130a240>, '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': 'dbb0bb31bf4a4c7db9ba1648000001b6-1500696907.17719-1539955509', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:10:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 03:10:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 03:10:12 INFO - Using env: {'DISPLAY': ':0', 03:10:12 INFO - 'HOME': '/home/cltbld', 03:10:12 INFO - 'LANG': 'en_US.UTF-8', 03:10:12 INFO - 'LANGUAGE': 'en_US:en', 03:10:12 INFO - 'LOGNAME': 'cltbld', 03:10:12 INFO - 'MAIL': '/var/mail/cltbld', 03:10:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:10:12 INFO - 'MOZ_NO_REMOTE': '1', 03:10:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:10:12 INFO - 'NO_EM_RESTART': '1', 03:10:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:10:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:10:12 INFO - 'PWD': '/builds/slave/test', 03:10:12 INFO - 'SHELL': '/bin/bash', 03:10:12 INFO - 'SHLVL': '1', 03:10:12 INFO - 'TERM': 'linux', 03:10:12 INFO - 'TMOUT': '86400', 03:10:12 INFO - 'USER': 'cltbld', 03:10:12 INFO - 'XDG_SESSION_COOKIE': 'dbb0bb31bf4a4c7db9ba1648000001b6-1500696907.17719-1539955509', 03:10:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:10:12 INFO - '_': '/tools/buildbot/bin/python'} 03:10:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:10:12 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:10:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:10:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:10:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:10:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:10:13 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:10:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:10:13 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:10:13 INFO - Installing collected packages: mozsystemmonitor 03:10:13 INFO - Running setup.py install for mozsystemmonitor 03:10:14 INFO - Successfully installed mozsystemmonitor 03:10:14 INFO - Cleaning up... 03:10:14 INFO - Return code: 0 03:10:14 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:10:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:10:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:10:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:10:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:10:14 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 0xf9c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1168a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x130bd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1308eb0>, '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 0x1309db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x130a240>, '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': 'dbb0bb31bf4a4c7db9ba1648000001b6-1500696907.17719-1539955509', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:10:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 03:10:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 03:10:14 INFO - Using env: {'DISPLAY': ':0', 03:10:14 INFO - 'HOME': '/home/cltbld', 03:10:14 INFO - 'LANG': 'en_US.UTF-8', 03:10:14 INFO - 'LANGUAGE': 'en_US:en', 03:10:14 INFO - 'LOGNAME': 'cltbld', 03:10:14 INFO - 'MAIL': '/var/mail/cltbld', 03:10:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:10:14 INFO - 'MOZ_NO_REMOTE': '1', 03:10:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:10:14 INFO - 'NO_EM_RESTART': '1', 03:10:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:10:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:10:14 INFO - 'PWD': '/builds/slave/test', 03:10:14 INFO - 'SHELL': '/bin/bash', 03:10:14 INFO - 'SHLVL': '1', 03:10:14 INFO - 'TERM': 'linux', 03:10:14 INFO - 'TMOUT': '86400', 03:10:14 INFO - 'USER': 'cltbld', 03:10:14 INFO - 'XDG_SESSION_COOKIE': 'dbb0bb31bf4a4c7db9ba1648000001b6-1500696907.17719-1539955509', 03:10:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:10:14 INFO - '_': '/tools/buildbot/bin/python'} 03:10:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:10:14 INFO - Downloading/unpacking jsonschema==2.5.1 03:10:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:10:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:10:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:10:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:10:15 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:10:15 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:10:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:10:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:10:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:10:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:10:15 INFO - Downloading functools32-3.2.3-2.tar.gz 03:10:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:10:15 INFO - warning: no files found matching '*.txt' 03:10:15 INFO - no previously-included directories found matching 'build' 03:10:15 INFO - no previously-included directories found matching 'dist' 03:10:15 INFO - no previously-included directories found matching '.git*' 03:10:15 INFO - Installing collected packages: jsonschema, functools32 03:10:15 INFO - Running setup.py install for functools32 03:10:15 INFO - warning: no files found matching '*.txt' 03:10:15 INFO - no previously-included directories found matching 'build' 03:10:15 INFO - no previously-included directories found matching 'dist' 03:10:15 INFO - no previously-included directories found matching '.git*' 03:10:15 INFO - Successfully installed jsonschema functools32 03:10:15 INFO - Cleaning up... 03:10:15 INFO - Return code: 0 03:10:15 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:10:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:10:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:10:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:10:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:10:15 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 0xf9c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1168a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x130bd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1308eb0>, '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 0x1309db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x130a240>, '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': 'dbb0bb31bf4a4c7db9ba1648000001b6-1500696907.17719-1539955509', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:10:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 03:10:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 03:10:15 INFO - Using env: {'DISPLAY': ':0', 03:10:15 INFO - 'HOME': '/home/cltbld', 03:10:15 INFO - 'LANG': 'en_US.UTF-8', 03:10:15 INFO - 'LANGUAGE': 'en_US:en', 03:10:15 INFO - 'LOGNAME': 'cltbld', 03:10:15 INFO - 'MAIL': '/var/mail/cltbld', 03:10:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:10:15 INFO - 'MOZ_NO_REMOTE': '1', 03:10:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:10:15 INFO - 'NO_EM_RESTART': '1', 03:10:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:10:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:10:15 INFO - 'PWD': '/builds/slave/test', 03:10:15 INFO - 'SHELL': '/bin/bash', 03:10:15 INFO - 'SHLVL': '1', 03:10:15 INFO - 'TERM': 'linux', 03:10:15 INFO - 'TMOUT': '86400', 03:10:15 INFO - 'USER': 'cltbld', 03:10:15 INFO - 'XDG_SESSION_COOKIE': 'dbb0bb31bf4a4c7db9ba1648000001b6-1500696907.17719-1539955509', 03:10:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:10:15 INFO - '_': '/tools/buildbot/bin/python'} 03:10:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:10:15 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:10:15 INFO - Cleaning up... 03:10:15 INFO - Return code: 0 03:10:15 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:10:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:10:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:10:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:10:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:10:15 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 0xf9c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1168a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x130bd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1308eb0>, '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 0x1309db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x130a240>, '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': 'dbb0bb31bf4a4c7db9ba1648000001b6-1500696907.17719-1539955509', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:10:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 03:10:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 03:10:15 INFO - Using env: {'DISPLAY': ':0', 03:10:15 INFO - 'HOME': '/home/cltbld', 03:10:15 INFO - 'LANG': 'en_US.UTF-8', 03:10:15 INFO - 'LANGUAGE': 'en_US:en', 03:10:15 INFO - 'LOGNAME': 'cltbld', 03:10:15 INFO - 'MAIL': '/var/mail/cltbld', 03:10:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:10:15 INFO - 'MOZ_NO_REMOTE': '1', 03:10:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:10:15 INFO - 'NO_EM_RESTART': '1', 03:10:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:10:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:10:15 INFO - 'PWD': '/builds/slave/test', 03:10:15 INFO - 'SHELL': '/bin/bash', 03:10:15 INFO - 'SHLVL': '1', 03:10:15 INFO - 'TERM': 'linux', 03:10:15 INFO - 'TMOUT': '86400', 03:10:15 INFO - 'USER': 'cltbld', 03:10:15 INFO - 'XDG_SESSION_COOKIE': 'dbb0bb31bf4a4c7db9ba1648000001b6-1500696907.17719-1539955509', 03:10:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:10:15 INFO - '_': '/tools/buildbot/bin/python'} 03:10:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:10:16 INFO - Downloading/unpacking blobuploader==1.2.4 03:10:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:10:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:10:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:10:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:10:17 INFO - Downloading blobuploader-1.2.4.tar.gz 03:10:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:10:17 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:10:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:10:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:10:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:10:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:10:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:10:17 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:10:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:10:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:10:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:10:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:10:17 INFO - Downloading docopt-0.6.1.tar.gz 03:10:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:10:17 INFO - Installing collected packages: blobuploader, requests, docopt 03:10:17 INFO - Running setup.py install for blobuploader 03:10:17 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:10:17 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:10:17 INFO - Running setup.py install for requests 03:10:18 INFO - Running setup.py install for docopt 03:10:18 INFO - Successfully installed blobuploader requests docopt 03:10:18 INFO - Cleaning up... 03:10:18 INFO - Return code: 0 03:10:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:10:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:10:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:10:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:10:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:10:18 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 0xf9c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1168a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x130bd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1308eb0>, '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 0x1309db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x130a240>, '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': 'dbb0bb31bf4a4c7db9ba1648000001b6-1500696907.17719-1539955509', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:10:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:10:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:10:18 INFO - Using env: {'DISPLAY': ':0', 03:10:18 INFO - 'HOME': '/home/cltbld', 03:10:18 INFO - 'LANG': 'en_US.UTF-8', 03:10:18 INFO - 'LANGUAGE': 'en_US:en', 03:10:18 INFO - 'LOGNAME': 'cltbld', 03:10:18 INFO - 'MAIL': '/var/mail/cltbld', 03:10:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:10:18 INFO - 'MOZ_NO_REMOTE': '1', 03:10:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:10:18 INFO - 'NO_EM_RESTART': '1', 03:10:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:10:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:10:18 INFO - 'PWD': '/builds/slave/test', 03:10:18 INFO - 'SHELL': '/bin/bash', 03:10:18 INFO - 'SHLVL': '1', 03:10:18 INFO - 'TERM': 'linux', 03:10:18 INFO - 'TMOUT': '86400', 03:10:18 INFO - 'USER': 'cltbld', 03:10:18 INFO - 'XDG_SESSION_COOKIE': 'dbb0bb31bf4a4c7db9ba1648000001b6-1500696907.17719-1539955509', 03:10:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:10:18 INFO - '_': '/tools/buildbot/bin/python'} 03:10:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:10:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:10:18 INFO - Running setup.py (path:/tmp/pip-rHN2TN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:10:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:10:18 INFO - Running setup.py (path:/tmp/pip-K7rVQe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:10:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:10:18 INFO - Running setup.py (path:/tmp/pip-88YAXe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:10:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:10:18 INFO - Running setup.py (path:/tmp/pip-LPINbM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:10:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:10:18 INFO - Running setup.py (path:/tmp/pip-kH8_Ym-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:10:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:10:19 INFO - Running setup.py (path:/tmp/pip-FCHbQF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:10:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:10:19 INFO - Running setup.py (path:/tmp/pip-uUCo06-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:10:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:10:19 INFO - Running setup.py (path:/tmp/pip-CNWbDr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:10:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:10:19 INFO - Running setup.py (path:/tmp/pip-rEIbZN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:10:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:10:19 INFO - Running setup.py (path:/tmp/pip-hp2wjD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:10:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:10:19 INFO - Running setup.py (path:/tmp/pip-VareJq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:10:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:10:19 INFO - Running setup.py (path:/tmp/pip-uXtv97-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:10:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:10:19 INFO - Running setup.py (path:/tmp/pip-XTDcv_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:10:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:10:19 INFO - Running setup.py (path:/tmp/pip-8uSPe5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:10:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:10:19 INFO - Running setup.py (path:/tmp/pip-C989oo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:10:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:10:19 INFO - Running setup.py (path:/tmp/pip-iX80Wp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:10:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:10:19 INFO - Running setup.py (path:/tmp/pip-UMnV0j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:10:19 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:10:19 INFO - Running setup.py install for manifestparser 03:10:19 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:10:20 INFO - Running setup.py install for mozcrash 03:10:20 INFO - Running setup.py install for mozdebug 03:10:20 INFO - Running setup.py install for mozdevice 03:10:20 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:10:20 INFO - Running setup.py install for mozfile 03:10:20 INFO - Running setup.py install for mozhttpd 03:10:20 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:10:20 INFO - Running setup.py install for mozinfo 03:10:20 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:10:20 INFO - Running setup.py install for mozInstall 03:10:20 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:10:20 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:10:20 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:10:20 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:10:20 INFO - Running setup.py install for mozleak 03:10:20 INFO - Running setup.py install for mozlog 03:10:20 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:10:20 INFO - Running setup.py install for moznetwork 03:10:20 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:10:21 INFO - Running setup.py install for mozprocess 03:10:21 INFO - Running setup.py install for mozprofile 03:10:21 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:10:21 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:10:21 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:10:21 INFO - Running setup.py install for mozrunner 03:10:21 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:10:21 INFO - Running setup.py install for mozscreenshot 03:10:21 INFO - Running setup.py install for moztest 03:10:21 INFO - Running setup.py install for mozversion 03:10:21 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:10:21 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:10:21 INFO - Cleaning up... 03:10:21 INFO - Return code: 0 03:10:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:10:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:10:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:10:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:10:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:10:21 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 0xf9c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1168a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x130bd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1308eb0>, '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 0x1309db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x130a240>, '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': 'dbb0bb31bf4a4c7db9ba1648000001b6-1500696907.17719-1539955509', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:10:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:10:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:10:21 INFO - Using env: {'DISPLAY': ':0', 03:10:21 INFO - 'HOME': '/home/cltbld', 03:10:21 INFO - 'LANG': 'en_US.UTF-8', 03:10:21 INFO - 'LANGUAGE': 'en_US:en', 03:10:21 INFO - 'LOGNAME': 'cltbld', 03:10:21 INFO - 'MAIL': '/var/mail/cltbld', 03:10:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:10:21 INFO - 'MOZ_NO_REMOTE': '1', 03:10:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:10:21 INFO - 'NO_EM_RESTART': '1', 03:10:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:10:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:10:21 INFO - 'PWD': '/builds/slave/test', 03:10:21 INFO - 'SHELL': '/bin/bash', 03:10:21 INFO - 'SHLVL': '1', 03:10:21 INFO - 'TERM': 'linux', 03:10:21 INFO - 'TMOUT': '86400', 03:10:21 INFO - 'USER': 'cltbld', 03:10:21 INFO - 'XDG_SESSION_COOKIE': 'dbb0bb31bf4a4c7db9ba1648000001b6-1500696907.17719-1539955509', 03:10:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:10:21 INFO - '_': '/tools/buildbot/bin/python'} 03:10:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:10:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:10:21 INFO - Running setup.py (path:/tmp/pip-CYoCNj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:10:21 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 03:10:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:10:21 INFO - Running setup.py (path:/tmp/pip-0eubSQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:10:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:10:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:10:22 INFO - Running setup.py (path:/tmp/pip-vM6PJm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:10:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:10:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:10:22 INFO - Running setup.py (path:/tmp/pip-aqhp_X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:10:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.51 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:10:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:10:22 INFO - Running setup.py (path:/tmp/pip-LadOZN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:10:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 03:10:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:10:22 INFO - Running setup.py (path:/tmp/pip-U6BaYy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:10:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 03:10:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:10:22 INFO - Running setup.py (path:/tmp/pip-oChlz7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:10:22 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)) 03:10:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:10:22 INFO - Running setup.py (path:/tmp/pip-O2wEfY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:10:22 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)) 03:10:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:10:22 INFO - Running setup.py (path:/tmp/pip-XfLeFa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:10:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 03:10:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:10:22 INFO - Running setup.py (path:/tmp/pip-yX8i_R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:10:22 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)) 03:10:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:10:22 INFO - Running setup.py (path:/tmp/pip-qBKktf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:10:22 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 03:10:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:10:22 INFO - Running setup.py (path:/tmp/pip-EcuWFf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:10:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 03:10:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:10:22 INFO - Running setup.py (path:/tmp/pip-A7Rs1H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:10:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 03:10:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:10:22 INFO - Running setup.py (path:/tmp/pip-tWprdK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:10:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 03:10:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:10:22 INFO - Running setup.py (path:/tmp/pip-KZirY7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:10:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 03:10:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:10:22 INFO - Running setup.py (path:/tmp/pip-ra1wSo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:10:23 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 03:10:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:10:23 INFO - Running setup.py (path:/tmp/pip-5qlGuV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:10:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 03:10:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:10:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:10:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:10:23 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:10:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:10:23 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)) 03:10:23 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:10:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:10:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:10:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:10:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:10:24 INFO - Downloading blessings-1.6.tar.gz 03:10:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:10:24 INFO - Installing collected packages: blessings 03:10:24 INFO - Running setup.py install for blessings 03:10:24 INFO - Successfully installed blessings 03:10:24 INFO - Cleaning up... 03:10:24 INFO - Return code: 0 03:10:24 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:10:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:10:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:10:24 INFO - Reading from file tmpfile_stdout 03:10:24 INFO - Current package versions: 03:10:24 INFO - argparse == 1.2.1 03:10:24 INFO - blessings == 1.6 03:10:24 INFO - blobuploader == 1.2.4 03:10:24 INFO - docopt == 0.6.1 03:10:24 INFO - functools32 == 3.2.3-2 03:10:24 INFO - jsonschema == 2.5.1 03:10:24 INFO - manifestparser == 1.1 03:10:24 INFO - mozInstall == 1.13 03:10:24 INFO - mozcrash == 1.0 03:10:24 INFO - mozdebug == 0.1 03:10:24 INFO - mozdevice == 0.51 03:10:24 INFO - mozfile == 1.2 03:10:24 INFO - mozhttpd == 0.7 03:10:24 INFO - mozinfo == 0.10 03:10:24 INFO - mozleak == 0.1 03:10:24 INFO - mozlog == 3.5 03:10:24 INFO - moznetwork == 0.27 03:10:24 INFO - mozprocess == 0.25 03:10:24 INFO - mozprofile == 0.28 03:10:24 INFO - mozrunner == 6.13 03:10:24 INFO - mozscreenshot == 0.1 03:10:24 INFO - mozsystemmonitor == 0.3 03:10:24 INFO - moztest == 0.8 03:10:24 INFO - mozversion == 1.4 03:10:24 INFO - psutil == 3.1.1 03:10:24 INFO - requests == 1.2.3 03:10:24 INFO - wsgiref == 0.1.2 03:10:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:10:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:10:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:10:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:10:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:10:24 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 0xf9c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1168a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x130bd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1308eb0>, '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 0x1309db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x130a240>, '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': 'dbb0bb31bf4a4c7db9ba1648000001b6-1500696907.17719-1539955509', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:10:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 03:10:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:10:24 INFO - Using env: {'DISPLAY': ':0', 03:10:24 INFO - 'HOME': '/home/cltbld', 03:10:24 INFO - 'LANG': 'en_US.UTF-8', 03:10:24 INFO - 'LANGUAGE': 'en_US:en', 03:10:24 INFO - 'LOGNAME': 'cltbld', 03:10:24 INFO - 'MAIL': '/var/mail/cltbld', 03:10:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:10:24 INFO - 'MOZ_NO_REMOTE': '1', 03:10:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:10:24 INFO - 'NO_EM_RESTART': '1', 03:10:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:10:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:10:24 INFO - 'PWD': '/builds/slave/test', 03:10:24 INFO - 'SHELL': '/bin/bash', 03:10:24 INFO - 'SHLVL': '1', 03:10:24 INFO - 'TERM': 'linux', 03:10:24 INFO - 'TMOUT': '86400', 03:10:24 INFO - 'USER': 'cltbld', 03:10:24 INFO - 'XDG_SESSION_COOKIE': 'dbb0bb31bf4a4c7db9ba1648000001b6-1500696907.17719-1539955509', 03:10:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:10:24 INFO - '_': '/tools/buildbot/bin/python'} 03:10:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:10:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:10:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 03:10:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 03:10:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:10:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 03:10:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 03:10:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 03:10:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 03:10:24 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 03:10:24 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 03:10:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:10:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:10:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:10:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:10:26 INFO - Downloading marionette_driver-1.4.0.tar.gz 03:10:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 03:10:26 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 11)) 03:10:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:10:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:10:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:10:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:10:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 03:10:26 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:10:26 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:10:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner>=6.9 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from marionette-driver>=1.4.0->-r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 03:10:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice>=0.37 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozrunner>=6.9->marionette-driver>=1.4.0->-r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 03:10:26 INFO - Installing collected packages: marionette-driver, simplejson 03:10:26 INFO - Running setup.py install for marionette-driver 03:10:26 INFO - Running setup.py install for simplejson 03:10:26 INFO - building 'simplejson._speedups' extension 03:10:26 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 03:10:27 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 03:10:27 INFO - Successfully installed marionette-driver simplejson 03:10:27 INFO - Cleaning up... 03:10:27 INFO - Return code: 0 03:10:27 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:10:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:10:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:10:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:10:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:10:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf9c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1168a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x130bd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1308eb0>, '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 0x1309db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x130a240>, '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': 'dbb0bb31bf4a4c7db9ba1648000001b6-1500696907.17719-1539955509', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:10:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 03:10:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 03:10:27 INFO - Using env: {'DISPLAY': ':0', 03:10:27 INFO - 'HOME': '/home/cltbld', 03:10:27 INFO - 'LANG': 'en_US.UTF-8', 03:10:27 INFO - 'LANGUAGE': 'en_US:en', 03:10:27 INFO - 'LOGNAME': 'cltbld', 03:10:27 INFO - 'MAIL': '/var/mail/cltbld', 03:10:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:10:27 INFO - 'MOZ_NO_REMOTE': '1', 03:10:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:10:27 INFO - 'NO_EM_RESTART': '1', 03:10:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:10:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:10:27 INFO - 'PWD': '/builds/slave/test', 03:10:27 INFO - 'SHELL': '/bin/bash', 03:10:27 INFO - 'SHLVL': '1', 03:10:27 INFO - 'TERM': 'linux', 03:10:27 INFO - 'TMOUT': '86400', 03:10:27 INFO - 'USER': 'cltbld', 03:10:27 INFO - 'XDG_SESSION_COOKIE': 'dbb0bb31bf4a4c7db9ba1648000001b6-1500696907.17719-1539955509', 03:10:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:10:27 INFO - '_': '/tools/buildbot/bin/python'} 03:10:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:10:27 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:10:27 INFO - Cleaning up... 03:10:27 INFO - Return code: 0 03:10:27 INFO - Running post-action listener: _resource_record_post_action 03:10:27 INFO - Running post-action listener: _start_resource_monitoring 03:10:27 INFO - Starting resource monitoring. 03:10:27 INFO - [mozharness: 2017-07-22 10:10:27.772686Z] Finished create-virtualenv step (success) 03:10:27 INFO - [mozharness: 2017-07-22 10:10:27.773765Z] Running install step. 03:10:27 INFO - Running pre-action listener: _resource_record_pre_action 03:10:27 INFO - Running main action method: install 03:10:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:10:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:10:27 INFO - Reading from file tmpfile_stdout 03:10:27 INFO - Detecting whether we're running mozinstall >=1.0... 03:10:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:10:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:10:28 INFO - Reading from file tmpfile_stdout 03:10:28 INFO - Output received: 03:10:28 INFO - Usage: mozinstall [options] installer 03:10:28 INFO - Options: 03:10:28 INFO - -h, --help show this help message and exit 03:10:28 INFO - -d DEST, --destination=DEST 03:10:28 INFO - Directory to install application into. [default: 03:10:28 INFO - "/builds/slave/test"] 03:10:28 INFO - --app=APP Application being installed. [default: firefox] 03:10:28 INFO - mkdir: /builds/slave/test/build/application 03:10:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 03:10:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 03:10:46 INFO - Reading from file tmpfile_stdout 03:10:46 INFO - Output received: 03:10:46 INFO - /builds/slave/test/build/application/firefox/firefox 03:10:46 INFO - Running post-action listener: _resource_record_post_action 03:10:46 INFO - [mozharness: 2017-07-22 10:10:46.107189Z] Finished install step (success) 03:10:46 INFO - [mozharness: 2017-07-22 10:10:46.107442Z] Running setup-mitmproxy step. 03:10:46 INFO - Running pre-action listener: _resource_record_pre_action 03:10:46 INFO - Running main action method: setup_mitmproxy 03:10:46 INFO - Skipping: mitmproxy is not required 03:10:46 INFO - Running post-action listener: _resource_record_post_action 03:10:46 INFO - [mozharness: 2017-07-22 10:10:46.108566Z] Finished setup-mitmproxy step (success) 03:10:46 INFO - [mozharness: 2017-07-22 10:10:46.108790Z] Running run-tests step. 03:10:46 INFO - Running pre-action listener: _resource_record_pre_action 03:10:46 INFO - Running pre-action listener: _set_gcov_prefix 03:10:46 INFO - Running main action method: run_tests 03:10:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:10:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:10:46 INFO - Python 2.7.3 03:10:46 INFO - Return code: 0 03:10:46 INFO - grabbing minidump binary from tooltool 03:10:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:10:46 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1308eb0>, '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 0x1309db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x130a240>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:10:46 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 03:10:46 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 03:10:46 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 03:10:46 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:10:46 INFO - Return code: 0 03:10:46 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:10:46 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:10:46 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:10:46 INFO - ENV: RUST_BACKTRACE is now 1 03:10:46 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:10:46 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:10:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/FpuMD3hSStKv4jAqluX4GQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-071', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 03:10:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/FpuMD3hSStKv4jAqluX4GQ/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-071 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 03:10:46 INFO - Using env: {'DISPLAY': ':0', 03:10:46 INFO - 'HOME': '/home/cltbld', 03:10:46 INFO - 'LANG': 'en_US.UTF-8', 03:10:46 INFO - 'LANGUAGE': 'en_US:en', 03:10:46 INFO - 'LOGNAME': 'cltbld', 03:10:46 INFO - 'MAIL': '/var/mail/cltbld', 03:10:46 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:10:46 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:10:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:10:46 INFO - 'MOZ_NO_REMOTE': '1', 03:10:46 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:10:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:10:46 INFO - 'NO_EM_RESTART': '1', 03:10:46 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:10:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:10:46 INFO - 'PWD': '/builds/slave/test', 03:10:46 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:10:46 INFO - 'RUST_BACKTRACE': '1', 03:10:46 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 03:10:46 INFO - 'SHELL': '/bin/bash', 03:10:46 INFO - 'SHLVL': '1', 03:10:46 INFO - 'STYLO_FORCE_ENABLED': '1', 03:10:46 INFO - 'TERM': 'linux', 03:10:46 INFO - 'TMOUT': '86400', 03:10:46 INFO - 'USER': 'cltbld', 03:10:46 INFO - 'XDG_SESSION_COOKIE': 'dbb0bb31bf4a4c7db9ba1648000001b6-1500696907.17719-1539955509', 03:10:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:10:46 INFO - '_': '/tools/buildbot/bin/python'} 03:10:46 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/FpuMD3hSStKv4jAqluX4GQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-071', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 03:10:46 INFO - mozversion application_buildid: 20170722092712 03:10:46 INFO - mozversion application_changeset: 7e496e6bac00d2acbf3dcd5615c13d4ac489724e 03:10:46 INFO - mozversion application_display_name: Nightly 03:10:46 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:10:46 INFO - mozversion application_name: Firefox 03:10:46 INFO - mozversion application_remotingname: firefox 03:10:46 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 03:10:46 INFO - mozversion application_vendor: Mozilla 03:10:46 INFO - mozversion application_version: 56.0a1 03:10:46 INFO - mozversion platform_buildid: 20170722092712 03:10:46 INFO - mozversion platform_changeset: 7e496e6bac00d2acbf3dcd5615c13d4ac489724e 03:10:46 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 03:10:46 INFO - mozversion platform_version: 56.0a1 03:10:46 INFO - using testdate: 1500718246 03:10:46 INFO - actual date: 1500718246 03:10:46 INFO - starting webserver on 'localhost:39813' 03:10:46 INFO - SUITE-START | Running 2 tests 03:10:46 INFO - TEST-START | dromaeo_css 03:10:46 INFO - Initialising browser for dromaeo_css test... 03:10:46 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:39813/getInfo.html -profile /tmp/tmp56Hnbc/profile 03:10:46 INFO - TEST-INFO | started process 3402 (/builds/slave/test/build/application/firefox/firefox http://localhost:39813/getInfo.html) 03:10:53 INFO - TEST-INFO | 3402: exit 0 03:10:55 INFO - Browser initialized. 03:10:55 INFO - Running cycle 1/1 for dromaeo_css test... 03:10:55 INFO - TEST-INFO | started process 3636 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp56Hnbc/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 03:11:07 INFO - PID 3636 | RSS: Main: 176644096 03:11:07 INFO - PID 3636 | 03:14:06 INFO - PID 3636 | Cycle 1(1): loaded http://localhost:39813/tests/dromaeo/cssquery-dojo.html (next: http://localhost:39813/tests/dromaeo/cssquery-ext.html) 03:14:07 INFO - PID 3636 | RSS: Main: 181919744 03:14:07 INFO - PID 3636 | 03:17:09 INFO - PID 3636 | Cycle 1(1): loaded http://localhost:39813/tests/dromaeo/cssquery-ext.html (next: http://localhost:39813/tests/dromaeo/cssquery-jquery.html) 03:17:10 INFO - PID 3636 | RSS: Main: 180248576 03:17:10 INFO - PID 3636 | 03:20:11 INFO - PID 3636 | Cycle 1(1): loaded http://localhost:39813/tests/dromaeo/cssquery-jquery.html (next: http://localhost:39813/tests/dromaeo/cssquery-mootools.html) 03:20:12 INFO - PID 3636 | RSS: Main: 181813248 03:20:12 INFO - PID 3636 | 03:23:14 INFO - PID 3636 | Cycle 1(1): loaded http://localhost:39813/tests/dromaeo/cssquery-mootools.html (next: http://localhost:39813/tests/dromaeo/cssquery-prototype.html) 03:23:14 INFO - PID 3636 | RSS: Main: 180985856 03:23:14 INFO - PID 3636 | 03:26:19 INFO - PID 3636 | Cycle 1(1): loaded http://localhost:39813/tests/dromaeo/cssquery-prototype.html (next: http://localhost:39813/tests/dromaeo/cssquery-yui.html) 03:26:19 INFO - PID 3636 | RSS: Main: 182292480 03:26:19 INFO - PID 3636 | 03:29:21 INFO - PID 3636 | Cycle 1(1): loaded http://localhost:39813/tests/dromaeo/cssquery-yui.html (next: http://localhost:39813/tests/dromaeo/cssquery-dojo.html) 03:29:21 INFO - PID 3636 | RSS: Main: 184111104 03:29:21 INFO - PID 3636 | 03:29:21 INFO - PID 3636 | __start_tp_report 03:29:21 INFO - PID 3636 | _x_x_mozilla_page_load 03:29:21 INFO - PID 3636 | _x_x_mozilla_page_load_details 03:29:21 INFO - PID 3636 | |i|pagename|runs| 03:29:21 INFO - PID 3636 | |0;dojo.html;3107.3474570340227;3130.405223007629;3135.1378370947973;3155.1638815713827;3157.5737275467804;6026.4576188143055;6170.506359491241;6179.660118693476;6198.504119670427;6247.187865577469;5939.07944268639;6079.118527813464;6101.389861013897;6127.63234205948;6149.077638354249;5529.751161197756;5532.585056120787;5547.77808887644;5569.470900264469;5741.224934633813;5708.286464191976;5719.59962802604;5726.427357264261;5735.397783232763;5805.970970145143;5446.611114165862;5604.187392828037;5626.746796394172;5694.658320500763;5708.8858222835515;5504.2294078829;5529.612927095105;5538.307711536058;5599.300087489064;5614.663120212759;5479.808206712746;5540.141278101861;5606.159076138571;5606.467385598362;5616.241807355996;5980.1328807323125;5998.070299103646;6004.699765011732;6035.185249991239;6107.26712794463;6507.837304067389;6508.121403610499;6540.182477190351;6587.2095348558005;6627.271000189975;6524.249711283168;6542.084108224853;6563.048357988065;6637.900431493483;6647.900281495781;5996.730147143433;6107.633541987406;6115.694215289218;6155.353687862755;6155.44600985909;6672.799816005528;6719.361660642231;6810.727570897207;6851.45188384928;6855.040294358794;6331.96834015827;6353.936460635335;6421.775237866652;6437.517186210959;6438.839029024218;6418.101465794793;6424.903626445607;6435.002574600944;6532.020196970492;6549.639769812706;6358.554901156967;6427.935720642828;6508.837279067967;6557.836054098686;6608.669566521655;6462.547621666532;6533.803985880431;6551.80344589663;6596.241432235259;6615.834604134839;5120.590352771844;5186.740662966837;5209.088409528317;5228.424873263938;5241.9737901310245;4467.039586488921;4468.151051300242;4471.396361491222;4484.798184081659;4513.345564893072;5654.830355089354;5669.971650141723;5676.545876329967;5691;5699.829005129853;6501.627888509474;6515;6518.282988871315;6585;6625.801225963229;5561.944380556223;5658.830235092953;5661.065924122556;5666.575006874501;5669.914951275734;5745.195672605839;5750.913736293959;5789.652620842763;5790.276215473066;5805.896879592864;6339.144215530844;6360.77737279193;6376.234851817811;6464.903026454607;6472.093906853044;6463.870722585616;6562.114114594468;6646.368594983469;6653.101831252912;6662.600243985376;6269.843253918689;6335.873282534231;6367.26776420699;6371.87256254863;6372.044193371032;6508.869822603616;6565.704543295658;6579.539432239697;6590.373914478117;6591.736330546724;6613.107230523818;6630.801075967729;6652.83367915806;6718.697658605277;6749.730010799513;6320.778772742932;6344.492440604833;6413.839654008687;6415.550911436341;6438.356164383524;6443.838904027437;6470.417662410406;6480.25477070143;6485.708143133476;6492.253390859923;6307.936920630918;6314.968425157845;6319.842003949938;6418.518611104092;6431.356864313531;6349.460295874902;6451.0645956337;6458.289588145206;6474.773382931763;6505.674716264073;6194.194754682043;6242.282137554058;6344.1118243445035;6344.524160687874;6368.267649220399 03:29:21 INFO - PID 3636 | |1;ext.html;777.4752042371401;790.1308560583362;808.2039191396475;837.9581020948953;840.1766269056328;40215;40506.39240411396;40926.18147637045;41026.794866025666;41038;37338.813305933436;37603.62396376036;37823.810880945624;37855.242895142146;37857.24285514288;6722.831929201772;6796.864062718742;6801.693923773442;7464;7575.659095340696;7371.26287371264;7431.888521672179;7454.515456495337;7454.552726836408;7461.179270280265;7476.36450901674;7488.925110748877;7512.399008079368;7516.812079698024;7524.586147761871;7428.888566671504;7484.251574842527;7489.513181643176;7496.512726672749;7497.775066748006;7456.291652293077;7496.437767167485;7513.699452021912;7532.058492688414;7532.661030253597;37092.07269818249;37435.812820935724;37462.43806342907;37538.24923501542;37543.81228093869;3434.3818112739696;3442.6901578857774;3447.67247111524;3454.447288433864;3456.395130852091;29760;29863.850680746673;29869.25326866824;29899.25251868699;29925.401491970257;4756.048790241965;4814.542618451242;4846.151923413388;4855.223164293696;4873.195922672755;188498;189080;190495;193126;199218.00390998097;48170.518294816604;48281.75859120682;48287.517124829006;48310.758446208245;48379.27431088537;49434.056594341;49684.254736178984;49866.501334986184;49867.75330616764;49885.01149885055;16064.75902861458;16108.516744497683;16185.271662775203;16213.10827904453;16378.754318685229;13568.457261709618;13573.321333933263;13583.320833958263;13594.25231612251;13594.456221751218;13947.302634868216;13962.650933726534;14139;14189.432422702976;14324.57026289213;5591.9720401397735;5630.268065151586;5714.514266287329;5748.223989761413;5848.9707551462825;965.710286913923;975.2782940624029;982.8525721141885;1009.7172791618359;1014.7919676466307;21417.78582214158;21428;21776.891115544637;21893.343199704035;22077.889610551843;1082.0856376361962;1096.4298564746287;1099.7140743406771;1100.6863044032411;1114.777044591085;11427.60003399877;11483.885161148282;11513.597024104116;11548.94225528867;11753.4710938008;233126;233993;234525;234576;234673;50112.24831627528;50563;50766.492335076175;50927;51084.744576276884;1316.8288122544009;1328.0504439325928;1343.6237853401062;1355.0853174107438;1451.7096580683906;20184.596308073462;21139.894300529013;21305.25431609886;21688.783112168676;22060.227892024344;35758.82120589484;35976.280474390886;35988.64011359958;36026.45960310545;36032.63967360293;198613;199703;200283;200663;200860;32441.755824418313;34733.65266347304;35490.64509354976;35557;35639.64360356363;43389;44783.55216447794;45219.773901130284;45308.32037519374;45387.31919021283;31982.200444989063;32596;32668;32861.67138328682;33016.174595635304;29506.852465737535;31168.532472012485;31904.6809531911;32067.6793232074;32452.837735812114;36173.457398138526;36341.63658363382;36368.09079773027;36610.45084323791;36656.63343366532;29277.707222927496;30540.541891872082;30978.69021309758;31348.119112853303;31601.051968440985;21956.341309760734;23086.769132308462;23272;23427.414314642272;23555.88222058879 03:29:21 INFO - PID 3636 | |2;jquery.html;560.6411896386313;563.6167406163808;566.3232437237502;572.4533070917274;589.7581991383532;21844.344669659917;22185.334439966828;22669.659955100688;22742.88628556857;22772.20297289593;26905;27311.180664580046;27346.316342091457;27375.315617109532;27453.588196177025;7012.298770122985;7178.066851309322;7182;7182.6408679566075;7199.028131202299;6607.5374723769355;6970.780113480146;7002.75490357835;7039.120109986252;7082.291770822928;7020.648967551628;7043.154821421436;7061.752838650648;7062.5056246062795;7070;7009.894851577231;7028.824279393005;7038.859222815566;7038.894416583756;7058.329458701415;6872.209695884987;6873.793786186422;6889.655517224169;6890.104286442781;6916.135483064617;30687.2328191797;30893;32330.353392932244;32875.6712432875;32949.341013179845;1909.322190622323;1944.2611807513197;1952.0044777163607;1955.1006536993;1961.3919684897585;19778.208871645118;20374.5925081499;20477;20518.255948244416;20537.897310513352;2436.5979613363775;2452.1172377943926;2498.1381423408893;2501.4371766352606;2513.208339373092;137711;141324.58675413218;141510.2924485371;141633;141787.29106354507;19540.034582363096;21721.67417488739;21802.454938626663;22308.77691223067;22512.437189070406;44151.558484415385;44158.77920610441;44321.77839110784;44371.556284437385;44501.55498445039;11726.824097638542;11871.406429678482;11911.285322880654;12109.152359334763;12113.212641178472;9803.754906127404;9827.262955278382;9899.158571521357;10056.949715251523;10067.093961543496;9267.860982085274;11647.6505704829;11815.232009919328;11869.109816763777;11916.52333906634;4386.232409328355;4393.472783266028;4442.800073996678;4460.665450091256;4476.597106260387;906.2523418179896;906.2613969614742;918.6555041859302;923.8337099322187;939.4316438554713;19371.51571210703;19526.12132454043;20025;20343.38969830878;20817.06323215459;997.4464172384396;1036.4247842447364;1041.2815157541272;1043.436544266103;1058.3226734889677;11142.888571114347;11153.498092585853;11161.888381116247;11229.887701122883;11594.71013224676;513371;515757;521791;527417;531055;122152.38923805323;128614;129649;129844;130228;1244.2596654990266;1270.0918843027096;1304.9739005219842;1307.5946456598294;1309.4369421148806;20286;21352.572948541252;21561.24535641245;21707.131714731866;21753.564928701653;55255.72372138114;56010.439895600524;56231.43768562426;58083.4191658078;58527;71364;71504.64247678936;72078;72860.27139728746;72982.63508682423;14501.854981450051;14828.925855370655;14913.776293355391;14941.103533788008;15262;22881.313560593208;23287.301380958597;23476.530469390174;24356.634650479904;24499.755002449747;18579.90710046441;18704.812951870306;19132.904335478233;19260.903695481433;19432.319868804523;16026.038437693309;17296;17539.912300438416;17887.910560447635;18151.27394904189;18487.53781155428;20271.59456810826;20335.796642033984;20354;20390.59218815645;15262.465813696912;15432.459863904709;15527.76708349353;15556.377744890531;15560.066396016275;17902.820971790115;19015.239390424227;19072.332468364097;19111.13999870037;19114.13986370589 03:29:21 INFO - PID 3636 | |3;mootools.html;1297.7015286484107;1349.156777014366;1353.3436283402548;1365.0649305225927;1366.8154799102124;13646.863531364683;13871.722565548684;14357.282135893216;14372.640683982892;14408.063475874062;13758.10572312799;14507.49223777168;14573.417063317482;14602.269886505659;14619.269036548183;2692.3269182704275;2725.0326134222364;2739.6164536964843;2742.561190209567;2745.3960128771637;2566.3327534840887;2652.986735066322;2658.2424009157394;2663.25428879913;2691.4213444109514;2712.4575084982985;2731.5219836528627;2744.217897899099;2754.807163498556;2771.584262360642;2493.002798880444;2502.4119331956977;2617.8560179190135;2623.47530493901;2685.597160425932;2574.5365834149848;2601.5707408277613;2610.9477810443686;2618.2145356393007;2625.54053040719;13853;14165.716685666332;14173.929130354385;14178.078424902451;14181.929090354586;7459.2167822378415;7734.458587898849;7743.806404839867;7744.225577442267;7748.845023099507;4999.951728598886;5142.894277730268;5183.50756678115;5189.065968125736;5236.659617124875;1826.379031129409;1834.8532117430573;1844.483544607512;1860.3953715042664;1881.6801143805449;22853.88573057124;22995.540089198123;23005.76994230053;23043.193488227833;23136.65295020576;6316.652584107826;6443.226812782496;6659.4006539411685;6682.799516014527;6692.230393504712;15568.766468502981;15595;15609.531714048597;15612.063276203464;15624.76562851558;7520.736774212876;7688.577128258;7693.730719424905;7703;7707.653155608011;6893.448524118058;7124.679389427384;7281.235470275545;7296.854062918818;7309.195988441267;5043;5196.454372290855;5198.740062996835;5218.9739051304505;5290.047791397586;1525.9465918692792;1528.144239226037;1529.1742459071977;1532.6168457885528;1549.8760099192039;883.5140672630027;892.973210803664;898.9865152022725;905.5064989580694;915.3592485260211;7203.675834587456;7244.963775181091;7307.232740562271;7311.963440182765;7345.3021962913435;707.9504434689522;709.868674295257;722.7614887087249;722.7687140115113;726.6076318787901;4467.419235499365;4820.180569303227;5188.7405629719115;5292.8147514837565;5295.576353891679;18863.339783107524;19868.70196947047;19883.801161988486;19891.104900279523;19891.900540497205;19059.698883922832;19291.324803631807;19598.412047638594;19638.116284766933;19683.507912302306;9981.700548983543;10616.94691526553;10651.786964260671;10653.094486968539;10780;7626.199249078989;8216.876746848922;8553.144685531646;8628.827423451621;8745.56272186401;15897.841021590099;16504.587385315463;17046.48860534186;17161.31354745846;17438.389656361967;16828;16889.155542223085;17381.739273910647;17389.47831565055;17785.19966601532;11203.831942520706;11435.656930292105;11478.88521114778;11517.481713322753;11556.59551915679;12187.268763874195;13244.404001820134;13263.469461221443;13275.66810829737;13308.201507909556;10382.636607718694;10792.730181745519;10810.621628242974;10919.181061420584;11022.669319920415;10420.635277765241;10481.42352170638;10782.406967616856;10829.29609575375;10942.069924056545;9235.538223088954;9312.348135630711;9416.340856140005;9425.764355890884;9435.481048542122;6451.4516266116025;6808.829779255559;6871.106756121672;6968.965155174192;7029.648517574203;6848.931510684829;6946.131733533309;7290.708371665074;7341.449391295781;7412.444066694911 03:29:21 INFO - PID 3636 | |4;prototype.html;475.40811689446645;496.4912365433004;508.15646027594187;508.6490321678042;513.6430181024188;6008.759649614021;6106.480949119325;6152.846178845525;6158.414950579699;6229.532785041129;5964.88070238595;5976.163337132794;5976.671283079429;6012.669303188323;6015.42082460935;4790.353302304188;4896.24108263218;4906.681065730734;4915.090708218991;4929.728864912428;4801.639877009221;4902.558769710726;4912.971363481946;5023.196288593826;5078.949210507903;4972.2044472884345;5015.423226328982;5092.337996060525;5102.515261050213;5104.974475127638;5025.497450254982;5109.540141387256;5125.282460455539;5136.845894623168;5138.383393992726;4747.643926705511;4778.976105119487;4779.259214821674;4781.6891902026255;4812.510929576064;5989.64062156272;6006.528400541852;6020.2775666919815;6037.849053773647;6043.667598282137;5835.912461313083;5837.357890632027;5903.321118071433;5903.763849446017;5929.525637948954;6428.646424446653;6439;6478;6533.542652014361;6570.605763654196;5229.686218826882;5229.816956406507;5236.921446178272;5239.266502689627;5267.815626453094;6778.491613129035;6819.386255237053;6841.247462779091;6879.5184337096425;6926.445884329241;5438.592105592096;5446.809361672323;5454;5455.1997840712465;5460.235567020621;5529.723513824292;5534;5544.944550554524;5547.472990066018;5552;5882.941170588239;5894.734736936848;5902.350741418526;5961.254843144607;5983.132445795335;6257.655828929453;6411;6507.837304067341;6531.934680653228;6557.442617377481;1857.7677790276216;1927.2387406974447;1930.652482553154;1939.447257531625;1945.1538580717433;1152.815549512074;1434.512265829623;1435.5191011011427;1447.7538818400897;1458.1105525629357;5610.32676078865;5693.544516438675;5706.71466426677;5738.971305143531;5785.681787501644;6461.741530338733;6488.7728929488185;6530.608163510205;6605.30644282353;6648.235452922879;5668.291463567054;5681.77272909079;5701.4298570142655;5710.600257981984;5769.68266745333;3498.9825050874583;3520.609359303061;3536.876209332661;3556.5376501054698;3562.4300111981956;6391.712372943229;6401.967990160112;6409.294977552466;6463.256725476536;6469.159009328757;6661.800145995628;6728.293529179366;6750.966245168841;6771.153605799275;6838.48711346651;6267.404596563228;6337.524685648687;6364.427201551883;6370.025292159446;6457.029766307363;6471.611703297817;6529.151210342625;6556.541042127005;6616.172978377703;6659.167604049494;6477.384648458389;6502.569434724353;6552.148220731275;6576.145101136822;6594.307597702172;6367.872642547216;6376.266729326187;6387.137736405526;6393.29673735898;6403.775867844603;4867.902641947212;4938.580220681282;4945.4807245238735;4966.6771659842;5015.84952451427;6511.967440162769;6583.440407565219;6618.477750117404;6675.232348279816;6717.899231511629;6366.395192456709;6367.713452894724;6368.203974503187;6377.681115944277;6465.709043092978;6281.466075383643;6350.618962862243;6376.9043464349;6386.361363863576;6432.263288911874;6329.968350158219;6400.423961843457;6417.454516365974;6433.228012638513;6435.678216089271;6370.394812492806;6447.935520644921;6510.73957041713;6514.2834288229205;6522.706478208397;5684.71576421169;6239.188905442264;6243.625382477066;6251.187345645037;6341 03:29:21 INFO - PID 3636 | |5;yui.html;882.8852249207602;912.5209265135804;916.3722849847851;923.3075193604797;927.4759760735186;17562.209700563475;18784.812151878476;18814;18820.15309311081;20245.29141480045;20760.792392076073;21567.67648485274;21723.456913577167;21731.23940662077;21762.12951481943;1032.4424810602284;1060.3902755915342;1061.7664113894969;1062.1078294232843;1062.219268837404;1012.1548506996667;1056.060106505211;1057.9629712960048;1059.7403636109163;1061.029158320136;1122.4556090296242;1124.8256520239336;1125.7917285302203;1125.9042981346595;1126.442411006553;1111.3332000799537;1112.9888701113007;1114.9944250278777;1118.1893127482592;1119.1829964126193;809.8339840332776;815.4210510537525;815.4373482297196;818.4884447220487;819.2176471469733;18872.90563547187;19670.606587868162;19719.80280197194;19808.40574782759;19838;20018.69971950422;20191.697124543145;20464;20746.792532074636;20759.68860467094;15972.76040859388;16192.919035404866;16303.429379971763;16349.182540873027;16396.426125085563;3474.9652503474895;3481;3482.686558209748;3490.6858382745677;3494.7378946579106;120871;122945.38527307396;126282;128572;128650.3567482166;14553.19957402353;15289.311980960883;15492.380304787683;15494.380224790882;15524.92237538805;29617.851910740308;29910.850445747634;30421.847890760404;30438.391232175232;30492.390152197277;8047.155048719917;8143.18568143181;8144.674213031531;8167.509949402936;8182.099969003405;3959.4060890866026;4016.6585840203325;4069.2878746219294;4070.0231944333145;4070.08423104805;5170.741462926914;5211.895762084737;5227.738613069331;5249.658772179796;5256.237845512379;969.5976169889417;993.7267251505749;999.9250056245811;1000.7898341348252;1002.5288114586133;646.544186348623;665.5374514712229;673.5487223560226;674.2852576269171;679.7756740275697;11000.504977276041;13158.473661053642;13743.931280343535;13754.793678094837;14238.644033899029;611.4069352727936;644.0596728775946;678.4402867634122;679.480197648799;686.3445409633788;5266.34170728659;5397.117142314895;5530.695811730394;5570;5795;94924.52537737267;97171.81169303069;97554;99091.50454247683;105401.47299263607;83967.58016210001;84909.57545212234;86288.56855715682;88692.66960995461;90505;75508;78612.60693696495;79756.60121699354;80749;83170;11939.82090268664;12027.45876435545;12066.939665301617;12512;12788.168769030355;36148.98422095591;36700;37338.87983360504;38278.808605956794;38805;63074.36925630685;64327.35672643214;65028.67485662542;66705.66647166733;67592.3240767586;18327.35854245095;18936.905315473334;19166.52083697863;19250.7112393317;19314.7102793461;20689.689654654892;20724.48188795232;21108.68336974916;21680.89159554255;21793.23723669664;18525.90737046306;18908.716369254198;19002.049897505345;19129.043547822832;19256.422307330802;18447.614060540778;18899.96050217196;19059.523511912314;19196.61606767829;19418.611627767084;18717.906410468404;18784.436466906016;18788.530286742942;19000.334988275343;19084.33204837824;12831.743365132459;13543.59369218925;14012.974420999068;14118.858811412165;14410.495632652806;13989.300534973007;14831;15409.152496612345;15584;15595.610109747347 03:29:21 INFO - PID 3636 | __end_tp_report 03:29:21 INFO - PID 3636 | __start_cc_report 03:29:21 INFO - PID 3636 | _x_x_mozilla_cycle_collect,389 03:29:21 INFO - PID 3636 | __end_cc_report 03:29:21 INFO - PID 3636 | __startTimestamp1500719361800__endTimestamp 03:29:21 INFO - PID 3636 | 03:29:21 INFO - PID 3636 | ------- Summary: start ------- 03:29:21 INFO - PID 3636 | Number of tests: 6 03:29:21 INFO - PID 3636 | 03:29:21 INFO - PID 3636 | [#0] dojo.html Cycles:165 Average:6038.99 Median:6331.97 stddev:719.55 (11.4%) stddev-sans-first:684.02 03:29:21 INFO - PID 3636 | Values: 3107.3 3130.4 3135.1 3155.2 3157.6 6026.5 6170.5 6179.7 6198.5 6247.2 5939.1 6079.1 6101.4 6127.6 6149.1 5529.8 5532.6 5547.8 5569.5 5741.2 5708.3 5719.6 5726.4 5735.4 5806.0 5446.6 5604.2 5626.7 5694.7 5708.9 5504.2 5529.6 5538.3 5599.3 5614.7 5479.8 5540.1 5606.2 5606.5 5616.2 5980.1 5998.1 6004.7 6035.2 6107.3 6507.8 6508.1 6540.2 6587.2 6627.3 6524.2 6542.1 6563.0 6637.9 6647.9 5996.7 6107.6 6115.7 6155.4 6155.4 6672.8 6719.4 6810.7 6851.5 6855.0 6332.0 6353.9 6421.8 6437.5 6438.8 6418.1 6424.9 6435.0 6532.0 6549.6 6358.6 6427.9 6508.8 6557.8 6608.7 6462.5 6533.8 6551.8 6596.2 6615.8 5120.6 5186.7 5209.1 5228.4 5242.0 4467.0 4468.2 4471.4 4484.8 4513.3 5654.8 5670.0 5676.5 5691.0 5699.8 6501.6 6515.0 6518.3 6585.0 6625.8 5561.9 5658.8 5661.1 5666.6 5669.9 5745.2 5750.9 5789.7 5790.3 5805.9 6339.1 6360.8 6376.2 6464.9 6472.1 6463.9 6562.1 6646.4 6653.1 6662.6 6269.8 6335.9 6367.3 6371.9 6372.0 6508.9 6565.7 6579.5 6590.4 6591.7 6613.1 6630.8 6652.8 6718.7 6749.7 6320.8 6344.5 6413.8 6415.6 6438.4 6443.8 6470.4 6480.3 6485.7 6492.3 6307.9 6315.0 6319.8 6418.5 6431.4 6349.5 6451.1 6458.3 6474.8 6505.7 6194.2 6242.3 6344.1 6344.5 6368.3 03:29:21 INFO - PID 3636 | 03:29:21 INFO - PID 3636 | [#1] ext.html Cycles:180 Average:37339.46 Median:35598.32 stddev:54347.16 (152.7%) stddev-sans-first:54430.28 03:29:21 INFO - PID 3636 | Values: 777.5 790.1 808.2 838.0 840.2 40215.0 40506.4 40926.2 41026.8 41038.0 37338.8 37603.6 37823.8 37855.2 37857.2 6722.8 6796.9 6801.7 7464.0 7575.7 7371.3 7431.9 7454.5 7454.6 7461.2 7476.4 7488.9 7512.4 7516.8 7524.6 7428.9 7484.3 7489.5 7496.5 7497.8 7456.3 7496.4 7513.7 7532.1 7532.7 37092.1 37435.8 37462.4 37538.2 37543.8 3434.4 3442.7 3447.7 3454.4 3456.4 29760.0 29863.9 29869.3 29899.3 29925.4 4756.0 4814.5 4846.2 4855.2 4873.2 188498.0 189080.0 190495.0 193126.0 199218.0 48170.5 48281.8 48287.5 48310.8 48379.3 49434.1 49684.3 49866.5 49867.8 49885.0 16064.8 16108.5 16185.3 16213.1 16378.8 13568.5 13573.3 13583.3 13594.3 13594.5 13947.3 13962.7 14139.0 14189.4 14324.6 5592.0 5630.3 5714.5 5748.2 5849.0 965.7 975.3 982.9 1009.7 1014.8 21417.8 21428.0 21776.9 21893.3 22077.9 1082.1 1096.4 1099.7 1100.7 1114.8 11427.6 11483.9 11513.6 11548.9 11753.5 233126.0 233993.0 234525.0 234576.0 234673.0 50112.2 50563.0 50766.5 50927.0 51084.7 1316.8 1328.1 1343.6 1355.1 1451.7 20184.6 21139.9 21305.3 21688.8 22060.2 35758.8 35976.3 35988.6 36026.5 36032.6 198613.0 199703.0 200283.0 200663.0 200860.0 32441.8 34733.7 35490.6 35557.0 35639.6 43389.0 44783.6 45219.8 45308.3 45387.3 31982.2 32596.0 32668.0 32861.7 33016.2 29506.9 31168.5 31904.7 32067.7 32452.8 36173.5 36341.6 36368.1 36610.5 36656.6 29277.7 30540.5 30978.7 31348.1 31601.1 21956.3 23086.8 23272.0 23427.4 23555.9 03:29:21 INFO - PID 3636 | 03:29:21 INFO - PID 3636 | [#2] jquery.html Cycles:180 Average:37511.78 Median:22410.61 stddev:87742.19 (391.5%) stddev-sans-first:87944.47 03:29:21 INFO - PID 3636 | Values: 560.6 563.6 566.3 572.5 589.8 21844.3 22185.3 22669.7 22742.9 22772.2 26905.0 27311.2 27346.3 27375.3 27453.6 7012.3 7178.1 7182.0 7182.6 7199.0 6607.5 6970.8 7002.8 7039.1 7082.3 7020.6 7043.2 7061.8 7062.5 7070.0 7009.9 7028.8 7038.9 7038.9 7058.3 6872.2 6873.8 6889.7 6890.1 6916.1 30687.2 30893.0 32330.4 32875.7 32949.3 1909.3 1944.3 1952.0 1955.1 1961.4 19778.2 20374.6 20477.0 20518.3 20537.9 2436.6 2452.1 2498.1 2501.4 2513.2 137711.0 141324.6 141510.3 141633.0 141787.3 19540.0 21721.7 21802.5 22308.8 22512.4 44151.6 44158.8 44321.8 44371.6 44501.6 11726.8 11871.4 11911.3 12109.2 12113.2 9803.8 9827.3 9899.2 10056.9 10067.1 9267.9 11647.7 11815.2 11869.1 11916.5 4386.2 4393.5 4442.8 4460.7 4476.6 906.3 906.3 918.7 923.8 939.4 19371.5 19526.1 20025.0 20343.4 20817.1 997.4 1036.4 1041.3 1043.4 1058.3 11142.9 11153.5 11161.9 11229.9 11594.7 513371.0 515757.0 521791.0 527417.0 531055.0 122152.4 128614.0 129649.0 129844.0 130228.0 1244.3 1270.1 1305.0 1307.6 1309.4 20286.0 21352.6 21561.2 21707.1 21753.6 55255.7 56010.4 56231.4 58083.4 58527.0 71364.0 71504.6 72078.0 72860.3 72982.6 14501.9 14828.9 14913.8 14941.1 15262.0 22881.3 23287.3 23476.5 24356.6 24499.8 18579.9 18704.8 19132.9 19260.9 19432.3 16026.0 17296.0 17539.9 17887.9 18151.3 18487.5 20271.6 20335.8 20354.0 20390.6 15262.5 15432.5 15527.8 15556.4 15560.1 17902.8 19015.2 19072.3 19111.1 19114.1 03:29:21 INFO - PID 3636 | 03:29:21 INFO - PID 3636 | [#3] mootools.html Cycles:180 Average:8723.94 Median:2618.04 stddev:5965.30 (227.9%) stddev-sans-first:5955.94 03:29:21 INFO - PID 3636 | Values: 1297.7 1349.2 1353.3 1365.1 1366.8 13646.9 13871.7 14357.3 14372.6 14408.1 13758.1 14507.5 14573.4 14602.3 14619.3 2692.3 2725.0 2739.6 2742.6 2745.4 2566.3 2653.0 2658.2 2663.3 2691.4 2712.5 2731.5 2744.2 2754.8 2771.6 2493.0 2502.4 2617.9 2623.5 2685.6 2574.5 2601.6 2610.9 2618.2 2625.5 13853.0 14165.7 14173.9 14178.1 14181.9 7459.2 7734.5 7743.8 7744.2 7748.8 5000.0 5142.9 5183.5 5189.1 5236.7 1826.4 1834.9 1844.5 1860.4 1881.7 22853.9 22995.5 23005.8 23043.2 23136.7 6316.7 6443.2 6659.4 6682.8 6692.2 15568.8 15595.0 15609.5 15612.1 15624.8 7520.7 7688.6 7693.7 7703.0 7707.7 6893.4 7124.7 7281.2 7296.9 7309.2 5043.0 5196.5 5198.7 5219.0 5290.0 1525.9 1528.1 1529.2 1532.6 1549.9 883.5 893.0 899.0 905.5 915.4 7203.7 7245.0 7307.2 7312.0 7345.3 708.0 709.9 722.8 722.8 726.6 4467.4 4820.2 5188.7 5292.8 5295.6 18863.3 19868.7 19883.8 19891.1 19891.9 19059.7 19291.3 19598.4 19638.1 19683.5 9981.7 10616.9 10651.8 10653.1 10780.0 7626.2 8216.9 8553.1 8628.8 8745.6 15897.8 16504.6 17046.5 17161.3 17438.4 16828.0 16889.2 17381.7 17389.5 17785.2 11203.8 11435.7 11478.9 11517.5 11556.6 12187.3 13244.4 13263.5 13275.7 13308.2 10382.6 10792.7 10810.6 10919.2 11022.7 10420.6 10481.4 10782.4 10829.3 10942.1 9235.5 9312.3 9416.3 9425.8 9435.5 6451.5 6808.8 6871.1 6969.0 7029.6 6848.9 6946.1 7290.7 7341.4 7412.4 03:29:21 INFO - PID 3636 | 03:29:21 INFO - PID 3636 | [#4] prototype.html Cycles:180 Average:5511.96 Median:6007.64 stddev:1475.64 (24.6%) stddev-sans-first:1430.54 03:29:21 INFO - PID 3636 | Values: 475.4 496.5 508.2 508.6 513.6 6008.8 6106.5 6152.8 6158.4 6229.5 5964.9 5976.2 5976.7 6012.7 6015.4 4790.4 4896.2 4906.7 4915.1 4929.7 4801.6 4902.6 4913.0 5023.2 5078.9 4972.2 5015.4 5092.3 5102.5 5105.0 5025.5 5109.5 5125.3 5136.8 5138.4 4747.6 4779.0 4779.3 4781.7 4812.5 5989.6 6006.5 6020.3 6037.8 6043.7 5835.9 5837.4 5903.3 5903.8 5929.5 6428.6 6439.0 6478.0 6533.5 6570.6 5229.7 5229.8 5236.9 5239.3 5267.8 6778.5 6819.4 6841.2 6879.5 6926.4 5438.6 5446.8 5454.0 5455.2 5460.2 5529.7 5534.0 5544.9 5547.5 5552.0 5882.9 5894.7 5902.4 5961.3 5983.1 6257.7 6411.0 6507.8 6531.9 6557.4 1857.8 1927.2 1930.7 1939.4 1945.2 1152.8 1434.5 1435.5 1447.8 1458.1 5610.3 5693.5 5706.7 5739.0 5785.7 6461.7 6488.8 6530.6 6605.3 6648.2 5668.3 5681.8 5701.4 5710.6 5769.7 3499.0 3520.6 3536.9 3556.5 3562.4 6391.7 6402.0 6409.3 6463.3 6469.2 6661.8 6728.3 6751.0 6771.2 6838.5 6267.4 6337.5 6364.4 6370.0 6457.0 6471.6 6529.2 6556.5 6616.2 6659.2 6477.4 6502.6 6552.1 6576.1 6594.3 6367.9 6376.3 6387.1 6393.3 6403.8 4867.9 4938.6 4945.5 4966.7 5015.8 6512.0 6583.4 6618.5 6675.2 6717.9 6366.4 6367.7 6368.2 6377.7 6465.7 6281.5 6350.6 6376.9 6386.4 6432.3 6330.0 6400.4 6417.5 6433.2 6435.7 6370.4 6447.9 6510.7 6514.3 6522.7 5684.7 6239.2 6243.6 6251.2 6341.0 03:29:21 INFO - PID 3636 | 03:29:21 INFO - PID 3636 | [#5] yui.html Cycles:180 Average:22825.84 Median:20576.84 stddev:29971.62 (145.7%) stddev-sans-first:30010.41 03:29:21 INFO - PID 3636 | Values: 882.9 912.5 916.4 923.3 927.5 17562.2 18784.8 18814.0 18820.2 20245.3 20760.8 21567.7 21723.5 21731.2 21762.1 1032.4 1060.4 1061.8 1062.1 1062.2 1012.2 1056.1 1058.0 1059.7 1061.0 1122.5 1124.8 1125.8 1125.9 1126.4 1111.3 1113.0 1115.0 1118.2 1119.2 809.8 815.4 815.4 818.5 819.2 18872.9 19670.6 19719.8 19808.4 19838.0 20018.7 20191.7 20464.0 20746.8 20759.7 15972.8 16192.9 16303.4 16349.2 16396.4 3475.0 3481.0 3482.7 3490.7 3494.7 120871.0 122945.4 126282.0 128572.0 128650.4 14553.2 15289.3 15492.4 15494.4 15524.9 29617.9 29910.9 30421.8 30438.4 30492.4 8047.2 8143.2 8144.7 8167.5 8182.1 3959.4 4016.7 4069.3 4070.0 4070.1 5170.7 5211.9 5227.7 5249.7 5256.2 969.6 993.7 999.9 1000.8 1002.5 646.5 665.5 673.5 674.3 679.8 11000.5 13158.5 13743.9 13754.8 14238.6 611.4 644.1 678.4 679.5 686.3 5266.3 5397.1 5530.7 5570.0 5795.0 94924.5 97171.8 97554.0 99091.5 105401.5 83967.6 84909.6 86288.6 88692.7 90505.0 75508.0 78612.6 79756.6 80749.0 83170.0 11939.8 12027.5 12066.9 12512.0 12788.2 36149.0 36700.0 37338.9 38278.8 38805.0 63074.4 64327.4 65028.7 66705.7 67592.3 18327.4 18936.9 19166.5 19250.7 19314.7 20689.7 20724.5 21108.7 21680.9 21793.2 18525.9 18908.7 19002.0 19129.0 19256.4 18447.6 18900.0 19059.5 19196.6 19418.6 18717.9 18784.4 18788.5 19000.3 19084.3 12831.7 13543.6 14013.0 14118.9 14410.5 13989.3 14831.0 15409.2 15584.0 15595.6 03:29:21 INFO - PID 3636 | -------- Summary: end -------- 03:29:21 INFO - PID 3636 | 03:29:22 INFO - TEST-INFO | 3636: exit 0 03:29:22 INFO - TEST-OK | dromaeo_css | took 1115997ms 03:29:22 INFO - TEST-START | kraken 03:29:22 INFO - Initialising browser for kraken test... 03:29:22 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:39813/getInfo.html -profile /tmp/tmpkxCyVP/profile 03:29:22 INFO - TEST-INFO | started process 4013 (/builds/slave/test/build/application/firefox/firefox http://localhost:39813/getInfo.html) 03:29:28 INFO - TEST-INFO | 4013: exit 0 03:29:28 INFO - Browser initialized. 03:29:28 INFO - Running cycle 1/1 for kraken test... 03:29:28 INFO - TEST-INFO | started process 4246 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkxCyVP/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 03:29:39 INFO - PID 4246 | RSS: Main: 177119232 03:29:39 INFO - PID 4246 | 03:29:42 INFO - PID 4246 | Cycle 1(1): loaded http://localhost:39813/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:39813/tests/kraken/driver.html?testName=audio-beat-detection) 03:29:43 INFO - PID 4246 | RSS: Main: 181211136 03:29:43 INFO - PID 4246 | 03:29:46 INFO - PID 4246 | Cycle 1(1): loaded http://localhost:39813/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:39813/tests/kraken/driver.html?testName=audio-dft) 03:29:46 INFO - PID 4246 | RSS: Main: 182247424 03:29:46 INFO - PID 4246 | 03:29:49 INFO - PID 4246 | Cycle 1(1): loaded http://localhost:39813/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:39813/tests/kraken/driver.html?testName=audio-fft) 03:29:50 INFO - PID 4246 | RSS: Main: 176046080 03:29:50 INFO - PID 4246 | 03:29:52 INFO - PID 4246 | Cycle 1(1): loaded http://localhost:39813/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:39813/tests/kraken/driver.html?testName=audio-oscillator) 03:29:53 INFO - PID 4246 | RSS: Main: 176926720 03:29:53 INFO - PID 4246 | 03:29:55 INFO - PID 4246 | Cycle 1(1): loaded http://localhost:39813/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:39813/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:29:56 INFO - PID 4246 | RSS: Main: 177123328 03:29:56 INFO - PID 4246 | 03:29:59 INFO - PID 4246 | Cycle 1(1): loaded http://localhost:39813/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:39813/tests/kraken/driver.html?testName=imaging-darkroom) 03:29:59 INFO - PID 4246 | RSS: Main: 179867648 03:29:59 INFO - PID 4246 | 03:30:03 INFO - PID 4246 | Cycle 1(1): loaded http://localhost:39813/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:39813/tests/kraken/driver.html?testName=imaging-desaturate) 03:30:03 INFO - PID 4246 | RSS: Main: 179539968 03:30:03 INFO - PID 4246 | 03:30:06 INFO - PID 4246 | Cycle 1(1): loaded http://localhost:39813/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:39813/tests/kraken/driver.html?testName=json-parse-financial) 03:30:07 INFO - PID 4246 | RSS: Main: 179761152 03:30:07 INFO - PID 4246 | 03:30:09 INFO - PID 4246 | Cycle 1(1): loaded http://localhost:39813/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:39813/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:30:09 INFO - PID 4246 | RSS: Main: 180412416 03:30:09 INFO - PID 4246 | 03:30:11 INFO - PID 4246 | Cycle 1(1): loaded http://localhost:39813/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:39813/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:30:12 INFO - PID 4246 | RSS: Main: 180174848 03:30:12 INFO - PID 4246 | 03:30:14 INFO - PID 4246 | Cycle 1(1): loaded http://localhost:39813/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:39813/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:30:14 INFO - PID 4246 | RSS: Main: 180043776 03:30:14 INFO - PID 4246 | 03:30:17 INFO - PID 4246 | Cycle 1(1): loaded http://localhost:39813/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:39813/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:30:18 INFO - PID 4246 | RSS: Main: 180121600 03:30:18 INFO - PID 4246 | 03:30:21 INFO - PID 4246 | Cycle 1(1): loaded http://localhost:39813/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:39813/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:30:22 INFO - PID 4246 | RSS: Main: 180396032 03:30:22 INFO - PID 4246 | 03:30:23 INFO - PID 4246 | Cycle 1(1): loaded http://localhost:39813/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:39813/tests/kraken/driver.html?testName=ai-astar) 03:30:24 INFO - PID 4246 | RSS: Main: 182091776 03:30:24 INFO - PID 4246 | 03:30:24 INFO - PID 4246 | __start_tp_report 03:30:24 INFO - PID 4246 | _x_x_mozilla_page_load 03:30:24 INFO - PID 4246 | _x_x_mozilla_page_load_details 03:30:24 INFO - PID 4246 | |i|pagename|runs| 03:30:24 INFO - PID 4246 | |0;ai-astar;109;110;97;110;111;112;113;108;111;111 03:30:24 INFO - PID 4246 | |1;audio-beat-detection;156;117;156;179;118;152;152;125;175;125 03:30:24 INFO - PID 4246 | |2;audio-dft;164;163;164;165;164;162;167;173;163;164 03:30:24 INFO - PID 4246 | |3;audio-fft;75;76;74;169;75;82;75;74;155;77 03:30:24 INFO - PID 4246 | |4;audio-oscillator;82;80;130;82;80;82;146;82;83;129 03:30:24 INFO - PID 4246 | |5;imaging-gaussian-blur;114;114;115;114;114;114;114;115;114;115 03:30:24 INFO - PID 4246 | |6;imaging-darkroom;151;150;151;152;151;150;153;151;152;151 03:30:24 INFO - PID 4246 | |7;imaging-desaturate;93;94;93;94;98;95;94;93;94;94 03:30:24 INFO - PID 4246 | |8;json-parse-financial;54;53;54;55;57;55;54;58;54;57 03:30:24 INFO - PID 4246 | |9;json-stringify-tinderbox;56;55;54;54;55;54;57;54;55;55 03:30:24 INFO - PID 4246 | |10;stanford-crypto-aes;80;79;78;80;82;90;79;79;78;77 03:30:24 INFO - PID 4246 | |11;stanford-crypto-ccm;130;127;135;131;139;123;123;129;143;168 03:30:24 INFO - PID 4246 | |12;stanford-crypto-pbkdf2;175;175;174;176;176;179;176;174;185;183 03:30:24 INFO - PID 4246 | |13;stanford-crypto-sha256-iterative;72;69;69;66;66;70;67;70;67;68 03:30:24 INFO - PID 4246 | __end_tp_report 03:30:24 INFO - PID 4246 | __start_cc_report 03:30:24 INFO - PID 4246 | _x_x_mozilla_cycle_collect,979 03:30:24 INFO - PID 4246 | __end_cc_report 03:30:24 INFO - PID 4246 | __startTimestamp1500719424144__endTimestamp 03:30:24 INFO - PID 4246 | 03:30:24 INFO - PID 4246 | ------- Summary: start ------- 03:30:24 INFO - PID 4246 | Number of tests: 14 03:30:24 INFO - PID 4246 | 03:30:24 INFO - PID 4246 | [#0] ai-astar Cycles:10 Average:109.20 Median:111.00 stddev:4.52 (4.1%) stddev-sans-first:4.79 03:30:24 INFO - PID 4246 | Values: 109.0 110.0 97.0 110.0 111.0 112.0 113.0 108.0 111.0 111.0 03:30:24 INFO - PID 4246 | 03:30:24 INFO - PID 4246 | [#1] audio-beat-detection Cycles:10 Average:145.50 Median:154.00 stddev:22.87 (14.8%) stddev-sans-first:23.94 03:30:24 INFO - PID 4246 | Values: 156.0 117.0 156.0 179.0 118.0 152.0 152.0 125.0 175.0 125.0 03:30:24 INFO - PID 4246 | 03:30:24 INFO - PID 4246 | [#2] audio-dft Cycles:10 Average:164.90 Median:164.00 stddev:3.14 (1.9%) stddev-sans-first:3.32 03:30:24 INFO - PID 4246 | Values: 164.0 163.0 164.0 165.0 164.0 162.0 167.0 173.0 163.0 164.0 03:30:24 INFO - PID 4246 | 03:30:24 INFO - PID 4246 | [#3] audio-fft Cycles:10 Average:93.20 Median:75.00 stddev:36.48 (48.6%) stddev-sans-first:38.10 03:30:24 INFO - PID 4246 | Values: 75.0 76.0 74.0 169.0 75.0 82.0 75.0 74.0 155.0 77.0 03:30:24 INFO - PID 4246 | 03:30:24 INFO - PID 4246 | [#4] audio-oscillator Cycles:10 Average:97.60 Median:82.00 stddev:26.21 (32.0%) stddev-sans-first:27.19 03:30:24 INFO - PID 4246 | Values: 82.0 80.0 130.0 82.0 80.0 82.0 146.0 82.0 83.0 129.0 03:30:24 INFO - PID 4246 | 03:30:24 INFO - PID 4246 | [#5] imaging-gaussian-blur Cycles:10 Average:114.30 Median:114.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 03:30:24 INFO - PID 4246 | Values: 114.0 114.0 115.0 114.0 114.0 114.0 114.0 115.0 114.0 115.0 03:30:24 INFO - PID 4246 | 03:30:24 INFO - PID 4246 | [#6] imaging-darkroom Cycles:10 Average:151.20 Median:151.00 stddev:0.92 (0.6%) stddev-sans-first:0.97 03:30:24 INFO - PID 4246 | Values: 151.0 150.0 151.0 152.0 151.0 150.0 153.0 151.0 152.0 151.0 03:30:24 INFO - PID 4246 | 03:30:24 INFO - PID 4246 | [#7] imaging-desaturate Cycles:10 Average:94.20 Median:94.00 stddev:1.48 (1.6%) stddev-sans-first:1.50 03:30:24 INFO - PID 4246 | Values: 93.0 94.0 93.0 94.0 98.0 95.0 94.0 93.0 94.0 94.0 03:30:24 INFO - PID 4246 | 03:30:24 INFO - PID 4246 | [#8] json-parse-financial Cycles:10 Average:55.10 Median:55.00 stddev:1.66 (3.0%) stddev-sans-first:1.72 03:30:24 INFO - PID 4246 | Values: 54.0 53.0 54.0 55.0 57.0 55.0 54.0 58.0 54.0 57.0 03:30:24 INFO - PID 4246 | 03:30:24 INFO - PID 4246 | [#9] json-stringify-tinderbox Cycles:10 Average:54.90 Median:55.00 stddev:0.99 (1.8%) stddev-sans-first:0.97 03:30:24 INFO - PID 4246 | Values: 56.0 55.0 54.0 54.0 55.0 54.0 57.0 54.0 55.0 55.0 03:30:24 INFO - PID 4246 | 03:30:24 INFO - PID 4246 | [#10] stanford-crypto-aes Cycles:10 Average:80.20 Median:79.50 stddev:3.71 (4.7%) stddev-sans-first:3.93 03:30:24 INFO - PID 4246 | Values: 80.0 79.0 78.0 80.0 82.0 90.0 79.0 79.0 78.0 77.0 03:30:24 INFO - PID 4246 | 03:30:24 INFO - PID 4246 | [#11] stanford-crypto-ccm Cycles:10 Average:134.80 Median:133.00 stddev:13.32 (10.0%) stddev-sans-first:14.02 03:30:24 INFO - PID 4246 | Values: 130.0 127.0 135.0 131.0 139.0 123.0 123.0 129.0 143.0 168.0 03:30:24 INFO - PID 4246 | 03:30:24 INFO - PID 4246 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:177.30 Median:176.00 stddev:3.83 (2.2%) stddev-sans-first:3.97 03:30:24 INFO - PID 4246 | Values: 175.0 175.0 174.0 176.0 176.0 179.0 176.0 174.0 185.0 183.0 03:30:24 INFO - PID 4246 | 03:30:24 INFO - PID 4246 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.40 Median:69.00 stddev:1.96 (2.8%) stddev-sans-first:1.58 03:30:24 INFO - PID 4246 | Values: 72.0 69.0 69.0 66.0 66.0 70.0 67.0 70.0 67.0 68.0 03:30:24 INFO - PID 4246 | -------- Summary: end -------- 03:30:24 INFO - PID 4246 | 03:30:24 INFO - PID 4246 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 03:30:24 INFO - TEST-INFO | 4246: exit 0 03:30:24 INFO - TEST-OK | kraken | took 62325ms 03:30:24 INFO - SUITE-END | took 1178s 03:30:25 INFO - Completed test suite (00:19:38) 03:30:25 INFO - javascript benchmark 03:30:25 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8530.176880894978, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3107.3474570340227, 3130.405223007629, 3135.1378370947973, 3155.1638815713827, 3157.5737275467804, 6026.4576188143055, 6170.506359491241, 6179.660118693476, 6198.504119670427, 6247.187865577469, 5939.07944268639, 6079.118527813464, 6101.389861013897, 6127.63234205948, 6149.077638354249, 5529.751161197756, 5532.585056120787, 5547.77808887644, 5569.470900264469, 5741.224934633813, 5708.286464191976, 5719.59962802604, 5726.427357264261, 5735.397783232763, 5805.970970145143, 5446.611114165862, 5604.187392828037, 5626.746796394172, 5694.658320500763, 5708.8858222835515, 5504.2294078829, 5529.612927095105, 5538.307711536058, 5599.300087489064, 5614.663120212759, 5479.808206712746, 5540.141278101861, 5606.159076138571, 5606.467385598362, 5616.241807355996, 5980.1328807323125, 5998.070299103646, 6004.699765011732, 6035.185249991239, 6107.26712794463, 6507.837304067389, 6508.121403610499, 6540.182477190351, 6587.2095348558005, 6627.271000189975, 6524.249711283168, 6542.084108224853, 6563.048357988065, 6637.900431493483, 6647.900281495781, 5996.730147143433, 6107.633541987406, 6115.694215289218, 6155.353687862755, 6155.44600985909, 6672.799816005528, 6719.361660642231, 6810.727570897207, 6851.45188384928, 6855.040294358794, 6331.96834015827, 6353.936460635335, 6421.775237866652, 6437.517186210959, 6438.839029024218, 6418.101465794793, 6424.903626445607, 6435.002574600944, 6532.020196970492, 6549.639769812706, 6358.554901156967, 6427.935720642828, 6508.837279067967, 6557.836054098686, 6608.669566521655, 6462.547621666532, 6533.803985880431, 6551.80344589663, 6596.241432235259, 6615.834604134839, 5120.590352771844, 5186.740662966837, 5209.088409528317, 5228.424873263938, 5241.9737901310245, 4467.039586488921, 4468.151051300242, 4471.396361491222, 4484.798184081659, 4513.345564893072, 5654.830355089354, 5669.971650141723, 5676.545876329967, 5691.0, 5699.829005129853, 6501.627888509474, 6515.0, 6518.282988871315, 6585.0, 6625.801225963229, 5561.944380556223, 5658.830235092953, 5661.065924122556, 5666.575006874501, 5669.914951275734, 5745.195672605839, 5750.913736293959, 5789.652620842763, 5790.276215473066, 5805.896879592864, 6339.144215530844, 6360.77737279193, 6376.234851817811, 6464.903026454607, 6472.093906853044, 6463.870722585616, 6562.114114594468, 6646.368594983469, 6653.101831252912, 6662.600243985376, 6269.843253918689, 6335.873282534231, 6367.26776420699, 6371.87256254863, 6372.044193371032, 6508.869822603616, 6565.704543295658, 6579.539432239697, 6590.373914478117, 6591.736330546724, 6613.107230523818, 6630.801075967729, 6652.83367915806, 6718.697658605277, 6749.730010799513, 6320.778772742932, 6344.492440604833, 6413.839654008687, 6415.550911436341, 6438.356164383524, 6443.838904027437, 6470.417662410406, 6480.25477070143, 6485.708143133476, 6492.253390859923, 6307.936920630918, 6314.968425157845, 6319.842003949938, 6418.518611104092, 6431.356864313531, 6349.460295874902, 6451.0645956337, 6458.289588145206, 6474.773382931763, 6505.674716264073, 6194.194754682043, 6242.282137554058, 6344.1118243445035, 6344.524160687874, 6368.267649220399], "value": 5984.993459286059, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [777.4752042371401, 790.1308560583362, 808.2039191396475, 837.9581020948953, 840.1766269056328, 40215.0, 40506.39240411396, 40926.18147637045, 41026.794866025666, 41038.0, 37338.813305933436, 37603.62396376036, 37823.810880945624, 37855.242895142146, 37857.24285514288, 6722.831929201772, 6796.864062718742, 6801.693923773442, 7464.0, 7575.659095340696, 7371.26287371264, 7431.888521672179, 7454.515456495337, 7454.552726836408, 7461.179270280265, 7476.36450901674, 7488.925110748877, 7512.399008079368, 7516.812079698024, 7524.586147761871, 7428.888566671504, 7484.251574842527, 7489.513181643176, 7496.512726672749, 7497.775066748006, 7456.291652293077, 7496.437767167485, 7513.699452021912, 7532.058492688414, 7532.661030253597, 37092.07269818249, 37435.812820935724, 37462.43806342907, 37538.24923501542, 37543.81228093869, 3434.3818112739696, 3442.6901578857774, 3447.67247111524, 3454.447288433864, 3456.395130852091, 29760.0, 29863.850680746673, 29869.25326866824, 29899.25251868699, 29925.401491970257, 4756.048790241965, 4814.542618451242, 4846.151923413388, 4855.223164293696, 4873.195922672755, 188498.0, 189080.0, 190495.0, 193126.0, 199218.00390998097, 48170.518294816604, 48281.75859120682, 48287.517124829006, 48310.758446208245, 48379.27431088537, 49434.056594341, 49684.254736178984, 49866.501334986184, 49867.75330616764, 49885.01149885055, 16064.75902861458, 16108.516744497683, 16185.271662775203, 16213.10827904453, 16378.754318685229, 13568.457261709618, 13573.321333933263, 13583.320833958263, 13594.25231612251, 13594.456221751218, 13947.302634868216, 13962.650933726534, 14139.0, 14189.432422702976, 14324.57026289213, 5591.9720401397735, 5630.268065151586, 5714.514266287329, 5748.223989761413, 5848.9707551462825, 965.710286913923, 975.2782940624029, 982.8525721141885, 1009.7172791618359, 1014.7919676466307, 21417.78582214158, 21428.0, 21776.891115544637, 21893.343199704035, 22077.889610551843, 1082.0856376361962, 1096.4298564746287, 1099.7140743406771, 1100.6863044032411, 1114.777044591085, 11427.60003399877, 11483.885161148282, 11513.597024104116, 11548.94225528867, 11753.4710938008, 233126.0, 233993.0, 234525.0, 234576.0, 234673.0, 50112.24831627528, 50563.0, 50766.492335076175, 50927.0, 51084.744576276884, 1316.8288122544009, 1328.0504439325928, 1343.6237853401062, 1355.0853174107438, 1451.7096580683906, 20184.596308073462, 21139.894300529013, 21305.25431609886, 21688.783112168676, 22060.227892024344, 35758.82120589484, 35976.280474390886, 35988.64011359958, 36026.45960310545, 36032.63967360293, 198613.0, 199703.0, 200283.0, 200663.0, 200860.0, 32441.755824418313, 34733.65266347304, 35490.64509354976, 35557.0, 35639.64360356363, 43389.0, 44783.55216447794, 45219.773901130284, 45308.32037519374, 45387.31919021283, 31982.200444989063, 32596.0, 32668.0, 32861.67138328682, 33016.174595635304, 29506.852465737535, 31168.532472012485, 31904.6809531911, 32067.6793232074, 32452.837735812114, 36173.457398138526, 36341.63658363382, 36368.09079773027, 36610.45084323791, 36656.63343366532, 29277.707222927496, 30540.541891872082, 30978.69021309758, 31348.119112853303, 31601.051968440985, 21956.341309760734, 23086.769132308462, 23272.0, 23427.414314642272, 23555.88222058879], "value": 16753.52920941933, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [560.6411896386313, 563.6167406163808, 566.3232437237502, 572.4533070917274, 589.7581991383532, 21844.344669659917, 22185.334439966828, 22669.659955100688, 22742.88628556857, 22772.20297289593, 26905.0, 27311.180664580046, 27346.316342091457, 27375.315617109532, 27453.588196177025, 7012.298770122985, 7178.066851309322, 7182.0, 7182.6408679566075, 7199.028131202299, 6607.5374723769355, 6970.780113480146, 7002.75490357835, 7039.120109986252, 7082.291770822928, 7020.648967551628, 7043.154821421436, 7061.752838650648, 7062.5056246062795, 7070.0, 7009.894851577231, 7028.824279393005, 7038.859222815566, 7038.894416583756, 7058.329458701415, 6872.209695884987, 6873.793786186422, 6889.655517224169, 6890.104286442781, 6916.135483064617, 30687.2328191797, 30893.0, 32330.353392932244, 32875.6712432875, 32949.341013179845, 1909.322190622323, 1944.2611807513197, 1952.0044777163607, 1955.1006536993, 1961.3919684897585, 19778.208871645118, 20374.5925081499, 20477.0, 20518.255948244416, 20537.897310513352, 2436.5979613363775, 2452.1172377943926, 2498.1381423408893, 2501.4371766352606, 2513.208339373092, 137711.0, 141324.58675413218, 141510.2924485371, 141633.0, 141787.29106354507, 19540.034582363096, 21721.67417488739, 21802.454938626663, 22308.77691223067, 22512.437189070406, 44151.558484415385, 44158.77920610441, 44321.77839110784, 44371.556284437385, 44501.55498445039, 11726.824097638542, 11871.406429678482, 11911.285322880654, 12109.152359334763, 12113.212641178472, 9803.754906127404, 9827.262955278382, 9899.158571521357, 10056.949715251523, 10067.093961543496, 9267.860982085274, 11647.6505704829, 11815.232009919328, 11869.109816763777, 11916.52333906634, 4386.232409328355, 4393.472783266028, 4442.800073996678, 4460.665450091256, 4476.597106260387, 906.2523418179896, 906.2613969614742, 918.6555041859302, 923.8337099322187, 939.4316438554713, 19371.51571210703, 19526.12132454043, 20025.0, 20343.38969830878, 20817.06323215459, 997.4464172384396, 1036.4247842447364, 1041.2815157541272, 1043.436544266103, 1058.3226734889677, 11142.888571114347, 11153.498092585853, 11161.888381116247, 11229.887701122883, 11594.71013224676, 513371.0, 515757.0, 521791.0, 527417.0, 531055.0, 122152.38923805323, 128614.0, 129649.0, 129844.0, 130228.0, 1244.2596654990266, 1270.0918843027096, 1304.9739005219842, 1307.5946456598294, 1309.4369421148806, 20286.0, 21352.572948541252, 21561.24535641245, 21707.131714731866, 21753.564928701653, 55255.72372138114, 56010.439895600524, 56231.43768562426, 58083.4191658078, 58527.0, 71364.0, 71504.64247678936, 72078.0, 72860.27139728746, 72982.63508682423, 14501.854981450051, 14828.925855370655, 14913.776293355391, 14941.103533788008, 15262.0, 22881.313560593208, 23287.301380958597, 23476.530469390174, 24356.634650479904, 24499.755002449747, 18579.90710046441, 18704.812951870306, 19132.904335478233, 19260.903695481433, 19432.319868804523, 16026.038437693309, 17296.0, 17539.912300438416, 17887.910560447635, 18151.27394904189, 18487.53781155428, 20271.59456810826, 20335.796642033984, 20354.0, 20390.59218815645, 15262.465813696912, 15432.459863904709, 15527.76708349353, 15556.377744890531, 15560.066396016275, 17902.820971790115, 19015.239390424227, 19072.332468364097, 19111.13999870037, 19114.13986370589], "value": 13092.958841052841, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1297.7015286484107, 1349.156777014366, 1353.3436283402548, 1365.0649305225927, 1366.8154799102124, 13646.863531364683, 13871.722565548684, 14357.282135893216, 14372.640683982892, 14408.063475874062, 13758.10572312799, 14507.49223777168, 14573.417063317482, 14602.269886505659, 14619.269036548183, 2692.3269182704275, 2725.0326134222364, 2739.6164536964843, 2742.561190209567, 2745.3960128771637, 2566.3327534840887, 2652.986735066322, 2658.2424009157394, 2663.25428879913, 2691.4213444109514, 2712.4575084982985, 2731.5219836528627, 2744.217897899099, 2754.807163498556, 2771.584262360642, 2493.002798880444, 2502.4119331956977, 2617.8560179190135, 2623.47530493901, 2685.597160425932, 2574.5365834149848, 2601.5707408277613, 2610.9477810443686, 2618.2145356393007, 2625.54053040719, 13853.0, 14165.716685666332, 14173.929130354385, 14178.078424902451, 14181.929090354586, 7459.2167822378415, 7734.458587898849, 7743.806404839867, 7744.225577442267, 7748.845023099507, 4999.951728598886, 5142.894277730268, 5183.50756678115, 5189.065968125736, 5236.659617124875, 1826.379031129409, 1834.8532117430573, 1844.483544607512, 1860.3953715042664, 1881.6801143805449, 22853.88573057124, 22995.540089198123, 23005.76994230053, 23043.193488227833, 23136.65295020576, 6316.652584107826, 6443.226812782496, 6659.4006539411685, 6682.799516014527, 6692.230393504712, 15568.766468502981, 15595.0, 15609.531714048597, 15612.063276203464, 15624.76562851558, 7520.736774212876, 7688.577128258, 7693.730719424905, 7703.0, 7707.653155608011, 6893.448524118058, 7124.679389427384, 7281.235470275545, 7296.854062918818, 7309.195988441267, 5043.0, 5196.454372290855, 5198.740062996835, 5218.9739051304505, 5290.047791397586, 1525.9465918692792, 1528.144239226037, 1529.1742459071977, 1532.6168457885528, 1549.8760099192039, 883.5140672630027, 892.973210803664, 898.9865152022725, 905.5064989580694, 915.3592485260211, 7203.675834587456, 7244.963775181091, 7307.232740562271, 7311.963440182765, 7345.3021962913435, 707.9504434689522, 709.868674295257, 722.7614887087249, 722.7687140115113, 726.6076318787901, 4467.419235499365, 4820.180569303227, 5188.7405629719115, 5292.8147514837565, 5295.576353891679, 18863.339783107524, 19868.70196947047, 19883.801161988486, 19891.104900279523, 19891.900540497205, 19059.698883922832, 19291.324803631807, 19598.412047638594, 19638.116284766933, 19683.507912302306, 9981.700548983543, 10616.94691526553, 10651.786964260671, 10653.094486968539, 10780.0, 7626.199249078989, 8216.876746848922, 8553.144685531646, 8628.827423451621, 8745.56272186401, 15897.841021590099, 16504.587385315463, 17046.48860534186, 17161.31354745846, 17438.389656361967, 16828.0, 16889.155542223085, 17381.739273910647, 17389.47831565055, 17785.19966601532, 11203.831942520706, 11435.656930292105, 11478.88521114778, 11517.481713322753, 11556.59551915679, 12187.268763874195, 13244.404001820134, 13263.469461221443, 13275.66810829737, 13308.201507909556, 10382.636607718694, 10792.730181745519, 10810.621628242974, 10919.181061420584, 11022.669319920415, 10420.635277765241, 10481.42352170638, 10782.406967616856, 10829.29609575375, 10942.069924056545, 9235.538223088954, 9312.348135630711, 9416.340856140005, 9425.764355890884, 9435.481048542122, 6451.4516266116025, 6808.829779255559, 6871.106756121672, 6968.965155174192, 7029.648517574203, 6848.931510684829, 6946.131733533309, 7290.708371665074, 7341.449391295781, 7412.444066694911], "value": 6330.48735720915, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [475.40811689446645, 496.4912365433004, 508.15646027594187, 508.6490321678042, 513.6430181024188, 6008.759649614021, 6106.480949119325, 6152.846178845525, 6158.414950579699, 6229.532785041129, 5964.88070238595, 5976.163337132794, 5976.671283079429, 6012.669303188323, 6015.42082460935, 4790.353302304188, 4896.24108263218, 4906.681065730734, 4915.090708218991, 4929.728864912428, 4801.639877009221, 4902.558769710726, 4912.971363481946, 5023.196288593826, 5078.949210507903, 4972.2044472884345, 5015.423226328982, 5092.337996060525, 5102.515261050213, 5104.974475127638, 5025.497450254982, 5109.540141387256, 5125.282460455539, 5136.845894623168, 5138.383393992726, 4747.643926705511, 4778.976105119487, 4779.259214821674, 4781.6891902026255, 4812.510929576064, 5989.64062156272, 6006.528400541852, 6020.2775666919815, 6037.849053773647, 6043.667598282137, 5835.912461313083, 5837.357890632027, 5903.321118071433, 5903.763849446017, 5929.525637948954, 6428.646424446653, 6439.0, 6478.0, 6533.542652014361, 6570.605763654196, 5229.686218826882, 5229.816956406507, 5236.921446178272, 5239.266502689627, 5267.815626453094, 6778.491613129035, 6819.386255237053, 6841.247462779091, 6879.5184337096425, 6926.445884329241, 5438.592105592096, 5446.809361672323, 5454.0, 5455.1997840712465, 5460.235567020621, 5529.723513824292, 5534.0, 5544.944550554524, 5547.472990066018, 5552.0, 5882.941170588239, 5894.734736936848, 5902.350741418526, 5961.254843144607, 5983.132445795335, 6257.655828929453, 6411.0, 6507.837304067341, 6531.934680653228, 6557.442617377481, 1857.7677790276216, 1927.2387406974447, 1930.652482553154, 1939.447257531625, 1945.1538580717433, 1152.815549512074, 1434.512265829623, 1435.5191011011427, 1447.7538818400897, 1458.1105525629357, 5610.32676078865, 5693.544516438675, 5706.71466426677, 5738.971305143531, 5785.681787501644, 6461.741530338733, 6488.7728929488185, 6530.608163510205, 6605.30644282353, 6648.235452922879, 5668.291463567054, 5681.77272909079, 5701.4298570142655, 5710.600257981984, 5769.68266745333, 3498.9825050874583, 3520.609359303061, 3536.876209332661, 3556.5376501054698, 3562.4300111981956, 6391.712372943229, 6401.967990160112, 6409.294977552466, 6463.256725476536, 6469.159009328757, 6661.800145995628, 6728.293529179366, 6750.966245168841, 6771.153605799275, 6838.48711346651, 6267.404596563228, 6337.524685648687, 6364.427201551883, 6370.025292159446, 6457.029766307363, 6471.611703297817, 6529.151210342625, 6556.541042127005, 6616.172978377703, 6659.167604049494, 6477.384648458389, 6502.569434724353, 6552.148220731275, 6576.145101136822, 6594.307597702172, 6367.872642547216, 6376.266729326187, 6387.137736405526, 6393.29673735898, 6403.775867844603, 4867.902641947212, 4938.580220681282, 4945.4807245238735, 4966.6771659842, 5015.84952451427, 6511.967440162769, 6583.440407565219, 6618.477750117404, 6675.232348279816, 6717.899231511629, 6366.395192456709, 6367.713452894724, 6368.203974503187, 6377.681115944277, 6465.709043092978, 6281.466075383643, 6350.618962862243, 6376.9043464349, 6386.361363863576, 6432.263288911874, 6329.968350158219, 6400.423961843457, 6417.454516365974, 6433.228012638513, 6435.678216089271, 6370.394812492806, 6447.935520644921, 6510.73957041713, 6514.2834288229205, 6522.706478208397, 5684.71576421169, 6239.188905442264, 6243.625382477066, 6251.187345645037, 6341.0], "value": 5086.442169667284, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [882.8852249207602, 912.5209265135804, 916.3722849847851, 923.3075193604797, 927.4759760735186, 17562.209700563475, 18784.812151878476, 18814.0, 18820.15309311081, 20245.29141480045, 20760.792392076073, 21567.67648485274, 21723.456913577167, 21731.23940662077, 21762.12951481943, 1032.4424810602284, 1060.3902755915342, 1061.7664113894969, 1062.1078294232843, 1062.219268837404, 1012.1548506996667, 1056.060106505211, 1057.9629712960048, 1059.7403636109163, 1061.029158320136, 1122.4556090296242, 1124.8256520239336, 1125.7917285302203, 1125.9042981346595, 1126.442411006553, 1111.3332000799537, 1112.9888701113007, 1114.9944250278777, 1118.1893127482592, 1119.1829964126193, 809.8339840332776, 815.4210510537525, 815.4373482297196, 818.4884447220487, 819.2176471469733, 18872.90563547187, 19670.606587868162, 19719.80280197194, 19808.40574782759, 19838.0, 20018.69971950422, 20191.697124543145, 20464.0, 20746.792532074636, 20759.68860467094, 15972.76040859388, 16192.919035404866, 16303.429379971763, 16349.182540873027, 16396.426125085563, 3474.9652503474895, 3481.0, 3482.686558209748, 3490.6858382745677, 3494.7378946579106, 120871.0, 122945.38527307396, 126282.0, 128572.0, 128650.3567482166, 14553.19957402353, 15289.311980960883, 15492.380304787683, 15494.380224790882, 15524.92237538805, 29617.851910740308, 29910.850445747634, 30421.847890760404, 30438.391232175232, 30492.390152197277, 8047.155048719917, 8143.18568143181, 8144.674213031531, 8167.509949402936, 8182.099969003405, 3959.4060890866026, 4016.6585840203325, 4069.2878746219294, 4070.0231944333145, 4070.08423104805, 5170.741462926914, 5211.895762084737, 5227.738613069331, 5249.658772179796, 5256.237845512379, 969.5976169889417, 993.7267251505749, 999.9250056245811, 1000.7898341348252, 1002.5288114586133, 646.544186348623, 665.5374514712229, 673.5487223560226, 674.2852576269171, 679.7756740275697, 11000.504977276041, 13158.473661053642, 13743.931280343535, 13754.793678094837, 14238.644033899029, 611.4069352727936, 644.0596728775946, 678.4402867634122, 679.480197648799, 686.3445409633788, 5266.34170728659, 5397.117142314895, 5530.695811730394, 5570.0, 5795.0, 94924.52537737267, 97171.81169303069, 97554.0, 99091.50454247683, 105401.47299263607, 83967.58016210001, 84909.57545212234, 86288.56855715682, 88692.66960995461, 90505.0, 75508.0, 78612.60693696495, 79756.60121699354, 80749.0, 83170.0, 11939.82090268664, 12027.45876435545, 12066.939665301617, 12512.0, 12788.168769030355, 36148.98422095591, 36700.0, 37338.87983360504, 38278.808605956794, 38805.0, 63074.36925630685, 64327.35672643214, 65028.67485662542, 66705.66647166733, 67592.3240767586, 18327.35854245095, 18936.905315473334, 19166.52083697863, 19250.7112393317, 19314.7102793461, 20689.689654654892, 20724.48188795232, 21108.68336974916, 21680.89159554255, 21793.23723669664, 18525.90737046306, 18908.716369254198, 19002.049897505345, 19129.043547822832, 19256.422307330802, 18447.614060540778, 18899.96050217196, 19059.523511912314, 19196.61606767829, 19418.611627767084, 18717.906410468404, 18784.436466906016, 18788.530286742942, 19000.334988275343, 19084.33204837824, 12831.743365132459, 13543.59369218925, 14012.974420999068, 14118.858811412165, 14410.495632652806, 13989.300534973007, 14831.0, 15409.152496612345, 15584.0, 15595.610109747347], "value": 9112.999721566113, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1540.8000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 110.0, 97.0, 110.0, 111.0, 112.0, 113.0, 108.0, 111.0, 111.0], "value": 109.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 117.0, 156.0, 179.0, 118.0, 152.0, 152.0, 125.0, 175.0, 125.0], "value": 145.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 163.0, 164.0, 165.0, 164.0, 162.0, 167.0, 173.0, 163.0, 164.0], "value": 164.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 74.0, 169.0, 75.0, 82.0, 75.0, 74.0, 155.0, 77.0], "value": 93.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 80.0, 130.0, 82.0, 80.0, 82.0, 146.0, 82.0, 83.0, 129.0], "value": 97.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 115.0, 114.0, 114.0, 114.0, 114.0, 115.0, 114.0, 115.0], "value": 114.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 150.0, 151.0, 152.0, 151.0, 150.0, 153.0, 151.0, 152.0, 151.0], "value": 151.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 94.0, 93.0, 94.0, 98.0, 95.0, 94.0, 93.0, 94.0, 94.0], "value": 94.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 53.0, 54.0, 55.0, 57.0, 55.0, 54.0, 58.0, 54.0, 57.0], "value": 55.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 55.0, 54.0, 54.0, 55.0, 54.0, 57.0, 54.0, 55.0, 55.0], "value": 54.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 79.0, 78.0, 80.0, 82.0, 90.0, 79.0, 79.0, 78.0, 77.0], "value": 80.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [130.0, 127.0, 135.0, 131.0, 139.0, 123.0, 123.0, 129.0, 143.0, 168.0], "value": 134.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [175.0, 175.0, 174.0, 176.0, 176.0, 179.0, 176.0, 174.0, 185.0, 183.0], "value": 177.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 69.0, 69.0, 66.0, 66.0, 70.0, 67.0, 70.0, 67.0, 68.0], "value": 68.4, "unit": "score"}]}]} 03:30:25 INFO - Return code: 0 03:30:25 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:30:25 INFO - # TBPL SUCCESS # 03:30:25 INFO - Running post-action listener: _package_coverage_data 03:30:25 INFO - Running post-action listener: _resource_record_post_action 03:30:25 INFO - [mozharness: 2017-07-22 10:30:25.444513Z] Finished run-tests step (success) 03:30:25 INFO - Running post-run listener: _resource_record_post_run 03:30:25 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 5177344; Write bytes: 441405440; Read time: 2204; Write time: 346836 03:30:25 INFO - TinderboxPrint: CPU usage
13.2% 03:30:25 INFO - TinderboxPrint: I/O read bytes / time
5,177,344 / 2,204 03:30:25 INFO - TinderboxPrint: I/O write bytes / time
441,405,440 / 346,836 03:30:25 INFO - TinderboxPrint: CPU idle
8,287.4 (86.8%) 03:30:25 INFO - TinderboxPrint: CPU user
1,204.2 (12.6%) 03:30:25 INFO - TinderboxPrint: Swap in / out
0 / 0 03:30:25 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 4096; Write bytes: 109404160; Read time: 220; Write time: 117808 03:30:25 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 03:30:25 INFO - run-tests - Wall time: 1179s; CPU: 13.0%; Read bytes: 2678784; Write bytes: 332001280; Read time: 1024; Write time: 229028 03:30:26 INFO - Running post-run listener: _upload_blobber_files 03:30:26 INFO - Blob upload gear active. 03:30:26 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:30:26 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 03:30:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 03:30:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 03:30:26 INFO - (blobuploader) - INFO - Open directory for files ... 03:30:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 03:30:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:30:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:30:27 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 03:30:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:30:27 INFO - (blobuploader) - INFO - Done attempting. 03:30:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:30:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:30:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:30:28 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:30:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:30:28 INFO - (blobuploader) - INFO - Done attempting. 03:30:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:30:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:30:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:30:31 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:30:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:30:31 INFO - (blobuploader) - INFO - Done attempting. 03:30:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:30:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:30:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:30:32 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:30:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:30:32 INFO - (blobuploader) - INFO - Done attempting. 03:30:32 INFO - (blobuploader) - INFO - Iteration through files over. 03:30:32 INFO - Return code: 0 03:30:32 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:30:32 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:30:32 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0b660fd12fc520f515b00e46246ee9f5a4e639e9f4d860080fdf53f1d9e67f13ff5b5712b9bd76d9d5093d9328025edbb4ad115f95fd62a1d6017f61c4c7f7fc", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3d43c1f2ed291a11147993596f26e0cf887df82d689441b95d6247fd9b24c6defc4752cc5b9afae44b9941ef9911e67254f0ac1bbc2221ff4d663688f679741f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/57ee9e29533d0b85dff61bf4fbea34a103305a5f803b4fb9901fc348cb0486a34bbf30ec968abb2f7a220d9520f68f1692c97c553633ec3a88fd7bd40eea0985", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f5aabd92158d8b0c4f91cc5f2f891d0673a225fdb46c69f274d3ded78236de13c4b7b7cbf0e2d51326dd4cd792fff90c69fcf33b2df274a288bdc6e13225bda1"} 03:30:32 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:30:32 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:30:32 INFO - Contents: 03:30:32 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0b660fd12fc520f515b00e46246ee9f5a4e639e9f4d860080fdf53f1d9e67f13ff5b5712b9bd76d9d5093d9328025edbb4ad115f95fd62a1d6017f61c4c7f7fc", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3d43c1f2ed291a11147993596f26e0cf887df82d689441b95d6247fd9b24c6defc4752cc5b9afae44b9941ef9911e67254f0ac1bbc2221ff4d663688f679741f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/57ee9e29533d0b85dff61bf4fbea34a103305a5f803b4fb9901fc348cb0486a34bbf30ec968abb2f7a220d9520f68f1692c97c553633ec3a88fd7bd40eea0985", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f5aabd92158d8b0c4f91cc5f2f891d0673a225fdb46c69f274d3ded78236de13c4b7b7cbf0e2d51326dd4cd792fff90c69fcf33b2df274a288bdc6e13225bda1"} 03:30:32 INFO - Running post-run listener: copy_logs_to_upload_dir 03:30:32 INFO - Copying logs to upload dir... 03:30:32 INFO - mkdir: /builds/slave/test/build/upload/logs 03:30:32 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1289.664346 ========= master_lag: 0.06 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 29 secs) (at 2017-07-22 03:30:31.809875) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-07-22 03:30:31.817464) ========= 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=dbb0bb31bf4a4c7db9ba1648000001b6-1500696907.17719-1539955509 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0b660fd12fc520f515b00e46246ee9f5a4e639e9f4d860080fdf53f1d9e67f13ff5b5712b9bd76d9d5093d9328025edbb4ad115f95fd62a1d6017f61c4c7f7fc", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3d43c1f2ed291a11147993596f26e0cf887df82d689441b95d6247fd9b24c6defc4752cc5b9afae44b9941ef9911e67254f0ac1bbc2221ff4d663688f679741f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/57ee9e29533d0b85dff61bf4fbea34a103305a5f803b4fb9901fc348cb0486a34bbf30ec968abb2f7a220d9520f68f1692c97c553633ec3a88fd7bd40eea0985", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f5aabd92158d8b0c4f91cc5f2f891d0673a225fdb46c69f274d3ded78236de13c4b7b7cbf0e2d51326dd4cd792fff90c69fcf33b2df274a288bdc6e13225bda1"} build_url:https://queue.taskcluster.net/v1/task/FpuMD3hSStKv4jAqluX4GQ/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011337 build_url: 'https://queue.taskcluster.net/v1/task/FpuMD3hSStKv4jAqluX4GQ/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0b660fd12fc520f515b00e46246ee9f5a4e639e9f4d860080fdf53f1d9e67f13ff5b5712b9bd76d9d5093d9328025edbb4ad115f95fd62a1d6017f61c4c7f7fc", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3d43c1f2ed291a11147993596f26e0cf887df82d689441b95d6247fd9b24c6defc4752cc5b9afae44b9941ef9911e67254f0ac1bbc2221ff4d663688f679741f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/57ee9e29533d0b85dff61bf4fbea34a103305a5f803b4fb9901fc348cb0486a34bbf30ec968abb2f7a220d9520f68f1692c97c553633ec3a88fd7bd40eea0985", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f5aabd92158d8b0c4f91cc5f2f891d0673a225fdb46c69f274d3ded78236de13c4b7b7cbf0e2d51326dd4cd792fff90c69fcf33b2df274a288bdc6e13225bda1"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-07-22 03:30:31.845019) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-07-22 03:30:31.845340) ========= 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=dbb0bb31bf4a4c7db9ba1648000001b6-1500696907.17719-1539955509 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004430 ========= master_lag: 0.09 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-07-22 03:30:31.937535) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-07-22 03:30:31.937875) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-07-22 03:30:31.938224) ========= ========= Total master_lag: 0.26 =========