builder: mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s slave: talos-linux64-ix-048 starttime: 1500718140.55 results: success (0) revision: 7e496e6bac00d2acbf3dcd5615c13d4ac489724e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-07-22 03:09:00.550905) ========= 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.551298) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-07-22 03:09:00.551565) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-07-22 03:09:00.571772) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-22 03:09:00.572046) ========= 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=fa44defc139c4ba8574fe040000001db-1500700471.24775-715283986 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.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 36.5M=0s 2017-07-22 03:09:01 (36.5 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.139122 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-22 03:09:00.733769) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-07-22 03:09:00.734091) ========= 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=fa44defc139c4ba8574fe040000001db-1500700471.24775-715283986 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014055 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-07-22 03:09:00.793830) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-22 03:09:00.794149) ========= 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=fa44defc139c4ba8574fe040000001db-1500700471.24775-715283986 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-07-22 03:09:01,466 truncating revision to first 12 chars 2017-07-22 03:09:01,466 Setting DEBUG logging. 2017-07-22 03:09:01,466 attempt 1/10 2017-07-22 03:09:01,466 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:01,959 unpacking tar archive at: mozilla-central-7e496e6bac00/testing/mozharness/ program finished with exit code 0 elapsedTime=0.927523 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-22 03:09:01.740321) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-07-22 03:09:01.740584) ========= script_repo_revision: 7e496e6bac00d2acbf3dcd5615c13d4ac489724e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-07-22 03:09:01.740946) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-07-22 03:09:01.741204) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-07-22 03:09:01.799733) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2017-07-22 03:09:01.800009) ========= /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=fa44defc139c4ba8574fe040000001db-1500700471.24775-715283986 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-048', 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.587025Z] 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.608088Z] Finished clobber step (success) 03:09:03 INFO - [mozharness: 2017-07-22 10:09:03.608192Z] 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_stylo_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 mozilla-central talos dromaeojs-e10s", 03:09:03 INFO - "stage_platform": "linux64-stylo", 03:09:03 INFO - "basedir": "/builds/slave/test", 03:09:03 INFO - "buildnumber": 41, 03:09:03 INFO - "platform": "ubuntu64_hw_stylo", 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": "L5dLWz_iR2WK2CbAMECRzg", 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-048", 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/L5dLWz_iR2WK2CbAMECRzg'}, attempt #1 03:09:04 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/L5dLWz_iR2WK2CbAMECRzg'}, 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:04 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/FpuMD3hSStKv4jAqluX4GQ/artifacts/public/build/target.tar.bz2 03:09:04 INFO - Set test_url: https://queue.taskcluster.net/v1/task/FpuMD3hSStKv4jAqluX4GQ/artifacts/public/build/test_packages.json 03:09:04 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/FpuMD3hSStKv4jAqluX4GQ/artifacts/public/build/target.crashreporter-symbols.zip 03:09:04 INFO - Running post-action listener: _resource_record_post_action 03:09:04 INFO - [mozharness: 2017-07-22 10:09:04.941454Z] Finished read-buildbot-config step (success) 03:09:04 INFO - [mozharness: 2017-07-22 10:09:04.941678Z] Running download-and-extract step. 03:09:04 INFO - Running pre-action listener: _resource_record_pre_action 03:09:04 INFO - Running main action method: download_and_extract 03:09:04 INFO - mkdir: /builds/slave/test/build/tests 03:09:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:09:04 INFO - trying https://queue.taskcluster.net/v1/task/FpuMD3hSStKv4jAqluX4GQ/artifacts/public/build/target.test_packages.json 03:09:04 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:04 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:35 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:35 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:35 INFO - Fetch https://queue.taskcluster.net/v1/task/FpuMD3hSStKv4jAqluX4GQ/artifacts/public/build/target.talos.tests.zip into memory 03:09:36 INFO - Content-Length response header: 14498971 03:09:36 INFO - Bytes received: 14498971 03:09:36 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:36 INFO - trying https://queue.taskcluster.net/v1/task/FpuMD3hSStKv4jAqluX4GQ/artifacts/public/build/target.tar.bz2 03:09:36 INFO - Downloading https://queue.taskcluster.net/v1/task/FpuMD3hSStKv4jAqluX4GQ/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 03:09:36 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:09:38 INFO - Downloaded 62105830 bytes. 03:09:38 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/FpuMD3hSStKv4jAqluX4GQ/artifacts/public/build/target.tar.bz2 03:09:38 INFO - mkdir: /builds/slave/test/properties 03:09:38 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:09:38 INFO - Writing to file /builds/slave/test/properties/build_url 03:09:38 INFO - Contents: 03:09:38 INFO - build_url:https://queue.taskcluster.net/v1/task/FpuMD3hSStKv4jAqluX4GQ/artifacts/public/build/target.tar.bz2 03:09:38 INFO - Running post-action listener: _resource_record_post_action 03:09:38 INFO - Running post-action listener: set_extra_try_arguments 03:09:38 INFO - [mozharness: 2017-07-22 10:09:38.399642Z] Finished download-and-extract step (success) 03:09:38 INFO - [mozharness: 2017-07-22 10:09:38.399869Z] Running populate-webroot step. 03:09:38 INFO - Running pre-action listener: _resource_record_pre_action 03:09:38 INFO - Running main action method: populate_webroot 03:09:38 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:09:38 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:09:38 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:09:38 INFO - '--tppagecycles', 03:09:38 INFO - '7'], 03:09:38 INFO - 'tests': ['tsvgm']}}, 03:09:38 INFO - 'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:09:38 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:09:38 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:09:38 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:09:38 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 03:09:38 INFO - 'talos_options': ['--disable-e10s'], 03:09:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:09:38 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 03:09:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:09:38 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 03:09:38 INFO - 'talos_options': ['--disable-e10s'], 03:09:38 INFO - 'tests': ['damp', 'tps']}, 03:09:38 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 03:09:38 INFO - 'tests': ['damp', 'tps']}, 03:09:38 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:09:38 INFO - 'tests': ['dromaeo_dom']}, 03:09:38 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:09:38 INFO - 'g4': {'talos_options': ['--disable-e10s'], 03:09:38 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 03:09:38 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 03:09:38 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 03:09:38 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 03:09:38 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:09:38 INFO - 'tests': ['a11yr', 03:09:38 INFO - 'ts_paint', 03:09:38 INFO - 'tpaint', 03:09:38 INFO - 'sessionrestore', 03:09:38 INFO - 'sessionrestore_no_auto_restore', 03:09:38 INFO - 'tabpaint']}, 03:09:38 INFO - 'other-e10s': {'tests': ['a11yr', 03:09:38 INFO - 'ts_paint', 03:09:38 INFO - 'tpaint', 03:09:38 INFO - 'sessionrestore', 03:09:38 INFO - 'sessionrestore_many_windows', 03:09:38 INFO - 'sessionrestore_no_auto_restore', 03:09:38 INFO - 'tabpaint']}, 03:09:38 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:09:38 INFO - 'ts_paint', 03:09:38 INFO - 'tpaint', 03:09:38 INFO - 'sessionrestore', 03:09:38 INFO - 'sessionrestore_many_windows', 03:09:38 INFO - 'sessionrestore_no_auto_restore', 03:09:38 INFO - 'tabpaint']}, 03:09:38 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:09:38 INFO - 'ts_paint', 03:09:38 INFO - 'tpaint', 03:09:38 INFO - 'sessionrestore', 03:09:38 INFO - 'sessionrestore_many_windows', 03:09:38 INFO - 'sessionrestore_no_auto_restore', 03:09:38 INFO - 'tabpaint']}, 03:09:38 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:09:38 INFO - 'tests': ['a11yr', 03:09:38 INFO - 'ts_paint', 03:09:38 INFO - 'tpaint', 03:09:38 INFO - 'sessionrestore', 03:09:38 INFO - 'sessionrestore_no_auto_restore', 03:09:38 INFO - 'tabpaint']}, 03:09:38 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:09:38 INFO - 'tests': ['a11yr', 03:09:38 INFO - 'ts_paint', 03:09:38 INFO - 'tpaint', 03:09:38 INFO - 'sessionrestore', 03:09:38 INFO - 'sessionrestore_no_auto_restore', 03:09:38 INFO - 'tabpaint']}, 03:09:38 INFO - 'perf-reftest': {'tests': ['bloom_basic']}, 03:09:38 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 03:09:38 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 03:09:38 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:09:38 INFO - 'talos_options': ['--mitmproxy', 03:09:38 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:09:38 INFO - '--firstNonBlankPaint'], 03:09:38 INFO - 'tests': ['quantum_pageload_google', 03:09:38 INFO - 'quantum_pageload_youtube', 03:09:38 INFO - 'quantum_pageload_amazon', 03:09:38 INFO - 'quantum_pageload_facebook']}, 03:09:38 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:09:38 INFO - 'tests': ['tsvgx', 03:09:38 INFO - 'tsvgr_opacity', 03:09:38 INFO - 'tart', 03:09:38 INFO - 'tscrollx', 03:09:38 INFO - 'cart', 03:09:38 INFO - 'tsvg_static']}, 03:09:38 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:09:38 INFO - 'tsvgr_opacity', 03:09:38 INFO - 'tart', 03:09:38 INFO - 'tscrollx', 03:09:38 INFO - 'cart', 03:09:38 INFO - 'tsvg_static']}, 03:09:38 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 03:09:38 INFO - 'talos_options': ['--disable-e10s'], 03:09:38 INFO - 'tests': ['tp5o']}, 03:09:38 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 03:09:38 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 03:09:38 INFO - 'talos_options': ['--disable-e10s', 03:09:38 INFO - '--xperf_path', 03:09:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:09:38 INFO - 'tests': ['tp5n']}, 03:09:38 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 03:09:38 INFO - 'talos_options': ['--xperf_path', 03:09:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:09:38 INFO - 'tests': ['tp5n']}}, 03:09:38 INFO - 'talos.zip': {'path': '', 03:09:38 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:09:38 INFO - Running post-action listener: _resource_record_post_action 03:09:38 INFO - [mozharness: 2017-07-22 10:09:38.418386Z] Finished populate-webroot step (success) 03:09:38 INFO - [mozharness: 2017-07-22 10:09:38.418477Z] Running create-virtualenv step. 03:09:38 INFO - Running pre-action listener: _resource_record_pre_action 03:09:38 INFO - Running main action method: create_virtualenv 03:09:38 INFO - Creating virtualenv /builds/slave/test/build/venv 03:09:38 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:09:38 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:09:38 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 03:09:38 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:09:38 INFO - Using real prefix '/usr' 03:09:38 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:09:39 INFO - Installing distribute.............................................................................................................................................................................................done. 03:09:41 INFO - Installing pip.................done. 03:09:41 INFO - Return code: 0 03:09:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 03:09:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 03:09:41 INFO - Reading from file tmpfile_stdout 03:09:41 INFO - Output received: 03:09:41 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:09:41 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:09:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:09:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:09:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:09:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:09:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19521f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b1ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cc1d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cbeeb0>, '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 0x1cbfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cc0240>, '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': 'fa44defc139c4ba8574fe040000001db-1500700471.24775-715283986', '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:09:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 03:09:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 03:09:41 INFO - Using env: {'DISPLAY': ':0', 03:09:41 INFO - 'HOME': '/home/cltbld', 03:09:41 INFO - 'LANG': 'en_US.UTF-8', 03:09:41 INFO - 'LANGUAGE': 'en_US:en', 03:09:41 INFO - 'LOGNAME': 'cltbld', 03:09:41 INFO - 'MAIL': '/var/mail/cltbld', 03:09:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:09:41 INFO - 'MOZ_NO_REMOTE': '1', 03:09:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:09:41 INFO - 'NO_EM_RESTART': '1', 03:09:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:09:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:09:41 INFO - 'PWD': '/builds/slave/test', 03:09:41 INFO - 'SHELL': '/bin/bash', 03:09:41 INFO - 'SHLVL': '1', 03:09:41 INFO - 'TERM': 'linux', 03:09:41 INFO - 'TMOUT': '86400', 03:09:41 INFO - 'USER': 'cltbld', 03:09:41 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1500700471.24775-715283986', 03:09:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:09:41 INFO - '_': '/tools/buildbot/bin/python'} 03:09:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:09:41 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:09:41 INFO - Cleaning up... 03:09:41 INFO - Return code: 0 03:09:41 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:09:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:09:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:09:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:09:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:09:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x19521f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b1ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cc1d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cbeeb0>, '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 0x1cbfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cc0240>, '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': 'fa44defc139c4ba8574fe040000001db-1500700471.24775-715283986', '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:09:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 03:09:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 03:09:41 INFO - Using env: {'DISPLAY': ':0', 03:09:41 INFO - 'HOME': '/home/cltbld', 03:09:41 INFO - 'LANG': 'en_US.UTF-8', 03:09:41 INFO - 'LANGUAGE': 'en_US:en', 03:09:41 INFO - 'LOGNAME': 'cltbld', 03:09:41 INFO - 'MAIL': '/var/mail/cltbld', 03:09:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:09:41 INFO - 'MOZ_NO_REMOTE': '1', 03:09:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:09:41 INFO - 'NO_EM_RESTART': '1', 03:09:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:09:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:09:41 INFO - 'PWD': '/builds/slave/test', 03:09:41 INFO - 'SHELL': '/bin/bash', 03:09:41 INFO - 'SHLVL': '1', 03:09:41 INFO - 'TERM': 'linux', 03:09:41 INFO - 'TMOUT': '86400', 03:09:41 INFO - 'USER': 'cltbld', 03:09:41 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1500700471.24775-715283986', 03:09:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:09:41 INFO - '_': '/tools/buildbot/bin/python'} 03:09:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:09:41 INFO - Downloading/unpacking psutil>=3.1.1 03:09:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:09:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:09:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:09:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:09:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:09:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:09:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:09:42 INFO - Installing collected packages: psutil 03:09:42 INFO - Running setup.py install for psutil 03:09:42 INFO - building 'psutil._psutil_linux' extension 03:09:42 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:09:43 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:09:43 INFO - building 'psutil._psutil_posix' extension 03:09:43 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:09:43 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:09:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:09:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:09:43 INFO - Successfully installed psutil 03:09:43 INFO - Cleaning up... 03:09:43 INFO - Return code: 0 03:09:43 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:09:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:09:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:09:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:09:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:09:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19521f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b1ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cc1d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cbeeb0>, '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 0x1cbfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cc0240>, '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': 'fa44defc139c4ba8574fe040000001db-1500700471.24775-715283986', '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:09:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 03:09:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 03:09:43 INFO - Using env: {'DISPLAY': ':0', 03:09:43 INFO - 'HOME': '/home/cltbld', 03:09:43 INFO - 'LANG': 'en_US.UTF-8', 03:09:43 INFO - 'LANGUAGE': 'en_US:en', 03:09:43 INFO - 'LOGNAME': 'cltbld', 03:09:43 INFO - 'MAIL': '/var/mail/cltbld', 03:09:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:09:43 INFO - 'MOZ_NO_REMOTE': '1', 03:09:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:09:43 INFO - 'NO_EM_RESTART': '1', 03:09:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:09:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:09:43 INFO - 'PWD': '/builds/slave/test', 03:09:43 INFO - 'SHELL': '/bin/bash', 03:09:43 INFO - 'SHLVL': '1', 03:09:43 INFO - 'TERM': 'linux', 03:09:43 INFO - 'TMOUT': '86400', 03:09:43 INFO - 'USER': 'cltbld', 03:09:43 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1500700471.24775-715283986', 03:09:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:09:43 INFO - '_': '/tools/buildbot/bin/python'} 03:09:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:09:43 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:09:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:09:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:09:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:09:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:09:44 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:09:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:09:44 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:09:44 INFO - Installing collected packages: mozsystemmonitor 03:09:44 INFO - Running setup.py install for mozsystemmonitor 03:09:44 INFO - Successfully installed mozsystemmonitor 03:09:44 INFO - Cleaning up... 03:09:44 INFO - Return code: 0 03:09:44 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:09:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:09:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:09:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:09:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:09:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19521f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b1ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cc1d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cbeeb0>, '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 0x1cbfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cc0240>, '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': 'fa44defc139c4ba8574fe040000001db-1500700471.24775-715283986', '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:09:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 03:09:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 03:09:44 INFO - Using env: {'DISPLAY': ':0', 03:09:44 INFO - 'HOME': '/home/cltbld', 03:09:44 INFO - 'LANG': 'en_US.UTF-8', 03:09:44 INFO - 'LANGUAGE': 'en_US:en', 03:09:44 INFO - 'LOGNAME': 'cltbld', 03:09:44 INFO - 'MAIL': '/var/mail/cltbld', 03:09:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:09:44 INFO - 'MOZ_NO_REMOTE': '1', 03:09:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:09:44 INFO - 'NO_EM_RESTART': '1', 03:09:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:09:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:09:44 INFO - 'PWD': '/builds/slave/test', 03:09:44 INFO - 'SHELL': '/bin/bash', 03:09:44 INFO - 'SHLVL': '1', 03:09:44 INFO - 'TERM': 'linux', 03:09:44 INFO - 'TMOUT': '86400', 03:09:44 INFO - 'USER': 'cltbld', 03:09:44 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1500700471.24775-715283986', 03:09:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:09:44 INFO - '_': '/tools/buildbot/bin/python'} 03:09:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:09:45 INFO - Downloading/unpacking jsonschema==2.5.1 03:09:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:09:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:09:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:09:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:09:46 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:09:46 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:09:46 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:09:46 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:09:46 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:09:46 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:09:46 INFO - Downloading functools32-3.2.3-2.tar.gz 03:09:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:09:46 INFO - warning: no files found matching '*.txt' 03:09:46 INFO - no previously-included directories found matching 'build' 03:09:46 INFO - no previously-included directories found matching 'dist' 03:09:46 INFO - no previously-included directories found matching '.git*' 03:09:46 INFO - Installing collected packages: jsonschema, functools32 03:09:46 INFO - Running setup.py install for functools32 03:09:46 INFO - warning: no files found matching '*.txt' 03:09:46 INFO - no previously-included directories found matching 'build' 03:09:46 INFO - no previously-included directories found matching 'dist' 03:09:46 INFO - no previously-included directories found matching '.git*' 03:09:46 INFO - Successfully installed jsonschema functools32 03:09:46 INFO - Cleaning up... 03:09:46 INFO - Return code: 0 03:09:46 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:09: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:09:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:09: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:09:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:09:46 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 0x19521f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b1ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cc1d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cbeeb0>, '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 0x1cbfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cc0240>, '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': 'fa44defc139c4ba8574fe040000001db-1500700471.24775-715283986', '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:09:46 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:09:46 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:09:46 INFO - Using env: {'DISPLAY': ':0', 03:09:46 INFO - 'HOME': '/home/cltbld', 03:09:46 INFO - 'LANG': 'en_US.UTF-8', 03:09:46 INFO - 'LANGUAGE': 'en_US:en', 03:09:46 INFO - 'LOGNAME': 'cltbld', 03:09:46 INFO - 'MAIL': '/var/mail/cltbld', 03:09:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:09:46 INFO - 'MOZ_NO_REMOTE': '1', 03:09:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:09:46 INFO - 'NO_EM_RESTART': '1', 03:09:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:09:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:09:46 INFO - 'PWD': '/builds/slave/test', 03:09:46 INFO - 'SHELL': '/bin/bash', 03:09:46 INFO - 'SHLVL': '1', 03:09:46 INFO - 'TERM': 'linux', 03:09:46 INFO - 'TMOUT': '86400', 03:09:46 INFO - 'USER': 'cltbld', 03:09:46 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1500700471.24775-715283986', 03:09:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:09:46 INFO - '_': '/tools/buildbot/bin/python'} 03:09:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:09:46 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:09:46 INFO - Cleaning up... 03:09:46 INFO - Return code: 0 03:09:46 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:09: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:09:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:09: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:09:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:09:46 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 0x19521f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b1ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cc1d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cbeeb0>, '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 0x1cbfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cc0240>, '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': 'fa44defc139c4ba8574fe040000001db-1500700471.24775-715283986', '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:09:46 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:09:46 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:09:46 INFO - Using env: {'DISPLAY': ':0', 03:09:46 INFO - 'HOME': '/home/cltbld', 03:09:46 INFO - 'LANG': 'en_US.UTF-8', 03:09:46 INFO - 'LANGUAGE': 'en_US:en', 03:09:46 INFO - 'LOGNAME': 'cltbld', 03:09:46 INFO - 'MAIL': '/var/mail/cltbld', 03:09:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:09:46 INFO - 'MOZ_NO_REMOTE': '1', 03:09:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:09:46 INFO - 'NO_EM_RESTART': '1', 03:09:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:09:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:09:46 INFO - 'PWD': '/builds/slave/test', 03:09:46 INFO - 'SHELL': '/bin/bash', 03:09:46 INFO - 'SHLVL': '1', 03:09:46 INFO - 'TERM': 'linux', 03:09:46 INFO - 'TMOUT': '86400', 03:09:46 INFO - 'USER': 'cltbld', 03:09:46 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1500700471.24775-715283986', 03:09:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:09:46 INFO - '_': '/tools/buildbot/bin/python'} 03:09:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:09:46 INFO - Downloading/unpacking blobuploader==1.2.4 03:09:46 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:09:46 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:09:46 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:09:46 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:09:48 INFO - Downloading blobuploader-1.2.4.tar.gz 03:09:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:09:48 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:09:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:09:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:09:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:09:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:09:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:09:48 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:09:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:09:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:09:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:09:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:09:48 INFO - Downloading docopt-0.6.1.tar.gz 03:09:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:09:48 INFO - Installing collected packages: blobuploader, requests, docopt 03:09:48 INFO - Running setup.py install for blobuploader 03:09:48 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:09:48 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:09:48 INFO - Running setup.py install for requests 03:09:49 INFO - Running setup.py install for docopt 03:09:49 INFO - Successfully installed blobuploader requests docopt 03:09:49 INFO - Cleaning up... 03:09:49 INFO - Return code: 0 03:09:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:09:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:09:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:09:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:09:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:09:49 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 0x19521f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b1ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cc1d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cbeeb0>, '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 0x1cbfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cc0240>, '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': 'fa44defc139c4ba8574fe040000001db-1500700471.24775-715283986', '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:09:49 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:09:49 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:09:49 INFO - Using env: {'DISPLAY': ':0', 03:09:49 INFO - 'HOME': '/home/cltbld', 03:09:49 INFO - 'LANG': 'en_US.UTF-8', 03:09:49 INFO - 'LANGUAGE': 'en_US:en', 03:09:49 INFO - 'LOGNAME': 'cltbld', 03:09:49 INFO - 'MAIL': '/var/mail/cltbld', 03:09:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:09:49 INFO - 'MOZ_NO_REMOTE': '1', 03:09:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:09:49 INFO - 'NO_EM_RESTART': '1', 03:09:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:09:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:09:49 INFO - 'PWD': '/builds/slave/test', 03:09:49 INFO - 'SHELL': '/bin/bash', 03:09:49 INFO - 'SHLVL': '1', 03:09:49 INFO - 'TERM': 'linux', 03:09:49 INFO - 'TMOUT': '86400', 03:09:49 INFO - 'USER': 'cltbld', 03:09:49 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1500700471.24775-715283986', 03:09:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:09:49 INFO - '_': '/tools/buildbot/bin/python'} 03:09:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:09:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:09:49 INFO - Running setup.py (path:/tmp/pip-08c20H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:09:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:09:49 INFO - Running setup.py (path:/tmp/pip-TFPJgH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:09:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:09:49 INFO - Running setup.py (path:/tmp/pip-Vhc4Xh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:09:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:09:49 INFO - Running setup.py (path:/tmp/pip-hpUIMI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:09:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:09:49 INFO - Running setup.py (path:/tmp/pip-XsqRqb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:09:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:09:49 INFO - Running setup.py (path:/tmp/pip-g8XMbl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:09:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:09:49 INFO - Running setup.py (path:/tmp/pip-t8ZxVJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:09:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:09:49 INFO - Running setup.py (path:/tmp/pip-ArtcbM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:09:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:09:50 INFO - Running setup.py (path:/tmp/pip-k0nFWw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:09:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:09:50 INFO - Running setup.py (path:/tmp/pip-EsEivY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:09:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:09:50 INFO - Running setup.py (path:/tmp/pip-jeB5ai-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:09:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:09:50 INFO - Running setup.py (path:/tmp/pip-9sZRM4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:09:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:09:50 INFO - Running setup.py (path:/tmp/pip-mT0Vk0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:09:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:09:50 INFO - Running setup.py (path:/tmp/pip-IVAz8p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:09:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:09:50 INFO - Running setup.py (path:/tmp/pip-SJMjgQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:09:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:09:50 INFO - Running setup.py (path:/tmp/pip-tDmeNj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:09:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:09:50 INFO - Running setup.py (path:/tmp/pip-pzyZsm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:09:50 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:09:50 INFO - Running setup.py install for manifestparser 03:09:50 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:09:50 INFO - Running setup.py install for mozcrash 03:09:50 INFO - Running setup.py install for mozdebug 03:09:50 INFO - Running setup.py install for mozdevice 03:09:51 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:09:51 INFO - Running setup.py install for mozfile 03:09:51 INFO - Running setup.py install for mozhttpd 03:09:51 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:09:51 INFO - Running setup.py install for mozinfo 03:09:51 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:09:51 INFO - Running setup.py install for mozInstall 03:09:51 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:09:51 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:09:51 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:09:51 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:09:51 INFO - Running setup.py install for mozleak 03:09:51 INFO - Running setup.py install for mozlog 03:09:51 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:09:51 INFO - Running setup.py install for moznetwork 03:09:51 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:09:51 INFO - Running setup.py install for mozprocess 03:09:51 INFO - Running setup.py install for mozprofile 03:09:51 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:09:51 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:09:51 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:09:51 INFO - Running setup.py install for mozrunner 03:09:52 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:09:52 INFO - Running setup.py install for mozscreenshot 03:09:52 INFO - Running setup.py install for moztest 03:09:52 INFO - Running setup.py install for mozversion 03:09:52 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:09:52 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:09:52 INFO - Cleaning up... 03:09:52 INFO - Return code: 0 03:09:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:09:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:09:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:09:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:09:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:09:52 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 0x19521f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b1ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cc1d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cbeeb0>, '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 0x1cbfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cc0240>, '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': 'fa44defc139c4ba8574fe040000001db-1500700471.24775-715283986', '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:09:52 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:09:52 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:09:52 INFO - Using env: {'DISPLAY': ':0', 03:09:52 INFO - 'HOME': '/home/cltbld', 03:09:52 INFO - 'LANG': 'en_US.UTF-8', 03:09:52 INFO - 'LANGUAGE': 'en_US:en', 03:09:52 INFO - 'LOGNAME': 'cltbld', 03:09:52 INFO - 'MAIL': '/var/mail/cltbld', 03:09:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:09:52 INFO - 'MOZ_NO_REMOTE': '1', 03:09:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:09:52 INFO - 'NO_EM_RESTART': '1', 03:09:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:09:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:09:52 INFO - 'PWD': '/builds/slave/test', 03:09:52 INFO - 'SHELL': '/bin/bash', 03:09:52 INFO - 'SHLVL': '1', 03:09:52 INFO - 'TERM': 'linux', 03:09:52 INFO - 'TMOUT': '86400', 03:09:52 INFO - 'USER': 'cltbld', 03:09:52 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1500700471.24775-715283986', 03:09:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:09:52 INFO - '_': '/tools/buildbot/bin/python'} 03:09:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:09:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:09:52 INFO - Running setup.py (path:/tmp/pip-kcOjQO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:09:52 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:09:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:09:52 INFO - Running setup.py (path:/tmp/pip-1SeKE3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:09:52 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:09:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:09:52 INFO - Running setup.py (path:/tmp/pip-jCuugE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:09:52 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:09:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:09:52 INFO - Running setup.py (path:/tmp/pip-gtuISd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:09:52 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:09:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:09:52 INFO - Running setup.py (path:/tmp/pip-GpBvd0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:09:53 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:09:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:09:53 INFO - Running setup.py (path:/tmp/pip-aLyLyS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:09:53 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:09:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:09:53 INFO - Running setup.py (path:/tmp/pip-befmF4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:09:53 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:09:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:09:53 INFO - Running setup.py (path:/tmp/pip-2rEyz0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:09:53 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:09:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:09:53 INFO - Running setup.py (path:/tmp/pip-fHq1dE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:09:53 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:09:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:09:53 INFO - Running setup.py (path:/tmp/pip-UXnWus-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:09:53 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:09:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:09:53 INFO - Running setup.py (path:/tmp/pip-2DZSoH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:09:53 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:09:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:09:53 INFO - Running setup.py (path:/tmp/pip-ksPkrD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:09:53 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:09:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:09:53 INFO - Running setup.py (path:/tmp/pip-Nn7PcK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:09:53 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:09:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:09:53 INFO - Running setup.py (path:/tmp/pip-cEno3D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:09:53 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:09:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:09:53 INFO - Running setup.py (path:/tmp/pip-UgKQUx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:09:53 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:09:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:09:53 INFO - Running setup.py (path:/tmp/pip-P8sxKD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:09:53 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:09:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:09:53 INFO - Running setup.py (path:/tmp/pip-wt2eUn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:09:53 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:09:53 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:09:53 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:09:53 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:09:53 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:09:53 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:09:53 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:09:53 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:09:53 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:09:53 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:09:53 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:09:53 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:09:54 INFO - Downloading blessings-1.6.tar.gz 03:09:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:09:55 INFO - Installing collected packages: blessings 03:09:55 INFO - Running setup.py install for blessings 03:09:55 INFO - Successfully installed blessings 03:09:55 INFO - Cleaning up... 03:09:55 INFO - Return code: 0 03:09:55 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:09:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:09:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:09:55 INFO - Reading from file tmpfile_stdout 03:09:55 INFO - Current package versions: 03:09:55 INFO - argparse == 1.2.1 03:09:55 INFO - blessings == 1.6 03:09:55 INFO - blobuploader == 1.2.4 03:09:55 INFO - docopt == 0.6.1 03:09:55 INFO - functools32 == 3.2.3-2 03:09:55 INFO - jsonschema == 2.5.1 03:09:55 INFO - manifestparser == 1.1 03:09:55 INFO - mozInstall == 1.13 03:09:55 INFO - mozcrash == 1.0 03:09:55 INFO - mozdebug == 0.1 03:09:55 INFO - mozdevice == 0.51 03:09:55 INFO - mozfile == 1.2 03:09:55 INFO - mozhttpd == 0.7 03:09:55 INFO - mozinfo == 0.10 03:09:55 INFO - mozleak == 0.1 03:09:55 INFO - mozlog == 3.5 03:09:55 INFO - moznetwork == 0.27 03:09:55 INFO - mozprocess == 0.25 03:09:55 INFO - mozprofile == 0.28 03:09:55 INFO - mozrunner == 6.13 03:09:55 INFO - mozscreenshot == 0.1 03:09:55 INFO - mozsystemmonitor == 0.3 03:09:55 INFO - moztest == 0.8 03:09:55 INFO - mozversion == 1.4 03:09:55 INFO - psutil == 3.1.1 03:09:55 INFO - requests == 1.2.3 03:09:55 INFO - wsgiref == 0.1.2 03:09:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:09:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:09:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:09:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:09:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:09:55 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 0x19521f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b1ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cc1d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cbeeb0>, '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 0x1cbfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cc0240>, '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': 'fa44defc139c4ba8574fe040000001db-1500700471.24775-715283986', '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:09:55 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:09:55 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:09:55 INFO - Using env: {'DISPLAY': ':0', 03:09:55 INFO - 'HOME': '/home/cltbld', 03:09:55 INFO - 'LANG': 'en_US.UTF-8', 03:09:55 INFO - 'LANGUAGE': 'en_US:en', 03:09:55 INFO - 'LOGNAME': 'cltbld', 03:09:55 INFO - 'MAIL': '/var/mail/cltbld', 03:09:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:09:55 INFO - 'MOZ_NO_REMOTE': '1', 03:09:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:09:55 INFO - 'NO_EM_RESTART': '1', 03:09:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:09:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:09:55 INFO - 'PWD': '/builds/slave/test', 03:09:55 INFO - 'SHELL': '/bin/bash', 03:09:55 INFO - 'SHLVL': '1', 03:09:55 INFO - 'TERM': 'linux', 03:09:55 INFO - 'TMOUT': '86400', 03:09:55 INFO - 'USER': 'cltbld', 03:09:55 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1500700471.24775-715283986', 03:09:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:09:55 INFO - '_': '/tools/buildbot/bin/python'} 03:09:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:09:55 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:09:55 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:09:55 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:09:55 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:09:55 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:09:55 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:09:55 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:09:55 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:09:55 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:09:55 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 03:09:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:09:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:09:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:09:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:09:56 INFO - Downloading marionette_driver-1.4.0.tar.gz 03:09:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 03:09:56 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 11)) 03:09:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:09:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:09:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:09:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:09:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 03:09:57 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:09:57 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:09:57 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:09:57 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:09:57 INFO - Installing collected packages: marionette-driver, simplejson 03:09:57 INFO - Running setup.py install for marionette-driver 03:09:57 INFO - Running setup.py install for simplejson 03:09:57 INFO - building 'simplejson._speedups' extension 03:09:57 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:09:58 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:09:58 INFO - Successfully installed marionette-driver simplejson 03:09:58 INFO - Cleaning up... 03:09:58 INFO - Return code: 0 03:09:58 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:09:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:09:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:09:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:09:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:09:58 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 0x19521f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b1ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cc1d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cbeeb0>, '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 0x1cbfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cc0240>, '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': 'fa44defc139c4ba8574fe040000001db-1500700471.24775-715283986', '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:09:58 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:09:58 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:09:58 INFO - Using env: {'DISPLAY': ':0', 03:09:58 INFO - 'HOME': '/home/cltbld', 03:09:58 INFO - 'LANG': 'en_US.UTF-8', 03:09:58 INFO - 'LANGUAGE': 'en_US:en', 03:09:58 INFO - 'LOGNAME': 'cltbld', 03:09:58 INFO - 'MAIL': '/var/mail/cltbld', 03:09:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:09:58 INFO - 'MOZ_NO_REMOTE': '1', 03:09:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:09:58 INFO - 'NO_EM_RESTART': '1', 03:09:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:09:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:09:58 INFO - 'PWD': '/builds/slave/test', 03:09:58 INFO - 'SHELL': '/bin/bash', 03:09:58 INFO - 'SHLVL': '1', 03:09:58 INFO - 'TERM': 'linux', 03:09:58 INFO - 'TMOUT': '86400', 03:09:58 INFO - 'USER': 'cltbld', 03:09:58 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1500700471.24775-715283986', 03:09:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:09:58 INFO - '_': '/tools/buildbot/bin/python'} 03:09:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:09:58 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:09:58 INFO - Cleaning up... 03:09:58 INFO - Return code: 0 03:09:58 INFO - Running post-action listener: _resource_record_post_action 03:09:58 INFO - Running post-action listener: _start_resource_monitoring 03:09:58 INFO - Starting resource monitoring. 03:09:58 INFO - [mozharness: 2017-07-22 10:09:58.473847Z] Finished create-virtualenv step (success) 03:09:58 INFO - [mozharness: 2017-07-22 10:09:58.474315Z] Running install step. 03:09:58 INFO - Running pre-action listener: _resource_record_pre_action 03:09:58 INFO - Running main action method: install 03:09:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:09:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:09:58 INFO - Reading from file tmpfile_stdout 03:09:58 INFO - Detecting whether we're running mozinstall >=1.0... 03:09:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:09:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:09:58 INFO - Reading from file tmpfile_stdout 03:09:58 INFO - Output received: 03:09:58 INFO - Usage: mozinstall [options] installer 03:09:58 INFO - Options: 03:09:58 INFO - -h, --help show this help message and exit 03:09:58 INFO - -d DEST, --destination=DEST 03:09:58 INFO - Directory to install application into. [default: 03:09:58 INFO - "/builds/slave/test"] 03:09:58 INFO - --app=APP Application being installed. [default: firefox] 03:09:58 INFO - mkdir: /builds/slave/test/build/application 03:09:58 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:09:58 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:16 INFO - Reading from file tmpfile_stdout 03:10:16 INFO - Output received: 03:10:16 INFO - /builds/slave/test/build/application/firefox/firefox 03:10:16 INFO - Running post-action listener: _resource_record_post_action 03:10:16 INFO - [mozharness: 2017-07-22 10:10:16.818045Z] Finished install step (success) 03:10:16 INFO - [mozharness: 2017-07-22 10:10:16.818297Z] Running setup-mitmproxy step. 03:10:16 INFO - Running pre-action listener: _resource_record_pre_action 03:10:16 INFO - Running main action method: setup_mitmproxy 03:10:16 INFO - Skipping: mitmproxy is not required 03:10:16 INFO - Running post-action listener: _resource_record_post_action 03:10:16 INFO - [mozharness: 2017-07-22 10:10:16.819426Z] Finished setup-mitmproxy step (success) 03:10:16 INFO - [mozharness: 2017-07-22 10:10:16.819646Z] Running run-tests step. 03:10:16 INFO - Running pre-action listener: _resource_record_pre_action 03:10:16 INFO - Running pre-action listener: _set_gcov_prefix 03:10:16 INFO - Running main action method: run_tests 03:10:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:10:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:10:16 INFO - Python 2.7.3 03:10:16 INFO - Return code: 0 03:10:16 INFO - grabbing minidump binary from tooltool 03:10:16 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:16 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 0x1cbeeb0>, '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 0x1cbfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cc0240>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:10:16 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:16 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:16 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:16 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:10:16 INFO - Return code: 0 03:10:16 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:10:16 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:10:16 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:10:16 INFO - ENV: RUST_BACKTRACE is now 1 03:10:16 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:10:16 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:10:16 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-048', '--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:16 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-048 --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:16 INFO - Using env: {'DISPLAY': ':0', 03:10:16 INFO - 'HOME': '/home/cltbld', 03:10:16 INFO - 'LANG': 'en_US.UTF-8', 03:10:16 INFO - 'LANGUAGE': 'en_US:en', 03:10:16 INFO - 'LOGNAME': 'cltbld', 03:10:16 INFO - 'MAIL': '/var/mail/cltbld', 03:10:16 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:10:16 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:10:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:10:16 INFO - 'MOZ_NO_REMOTE': '1', 03:10:16 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:10:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:10:16 INFO - 'NO_EM_RESTART': '1', 03:10:16 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:10:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:10:16 INFO - 'PWD': '/builds/slave/test', 03:10:16 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:10:16 INFO - 'RUST_BACKTRACE': '1', 03:10:16 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 03:10:16 INFO - 'SHELL': '/bin/bash', 03:10:16 INFO - 'SHLVL': '1', 03:10:16 INFO - 'STYLO_FORCE_ENABLED': '1', 03:10:16 INFO - 'TERM': 'linux', 03:10:16 INFO - 'TMOUT': '86400', 03:10:16 INFO - 'USER': 'cltbld', 03:10:16 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1500700471.24775-715283986', 03:10:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:10:16 INFO - '_': '/tools/buildbot/bin/python'} 03:10:16 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-048', '--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:17 INFO - mozversion application_buildid: 20170722092712 03:10:17 INFO - mozversion application_changeset: 7e496e6bac00d2acbf3dcd5615c13d4ac489724e 03:10:17 INFO - mozversion application_display_name: Nightly 03:10:17 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:10:17 INFO - mozversion application_name: Firefox 03:10:17 INFO - mozversion application_remotingname: firefox 03:10:17 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 03:10:17 INFO - mozversion application_vendor: Mozilla 03:10:17 INFO - mozversion application_version: 56.0a1 03:10:17 INFO - mozversion platform_buildid: 20170722092712 03:10:17 INFO - mozversion platform_changeset: 7e496e6bac00d2acbf3dcd5615c13d4ac489724e 03:10:17 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 03:10:17 INFO - mozversion platform_version: 56.0a1 03:10:17 INFO - using testdate: 1500718217 03:10:17 INFO - actual date: 1500718217 03:10:17 INFO - starting webserver on 'localhost:46426' 03:10:17 INFO - SUITE-START | Running 2 tests 03:10:17 INFO - TEST-START | dromaeo_css 03:10:17 INFO - Initialising browser for dromaeo_css test... 03:10:17 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:46426/getInfo.html -profile /tmp/tmpRhbqVA/profile 03:10:17 INFO - TEST-INFO | started process 4830 (/builds/slave/test/build/application/firefox/firefox http://localhost:46426/getInfo.html) 03:10:23 INFO - TEST-INFO | 4830: exit 0 03:10:24 INFO - Browser initialized. 03:10:24 INFO - Running cycle 1/1 for dromaeo_css test... 03:10:24 INFO - TEST-INFO | started process 5059 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpRhbqVA/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 03:10:35 INFO - PID 5059 | RSS: Main: 176865280 03:10:35 INFO - PID 5059 | 03:13:34 INFO - PID 5059 | Cycle 1(1): loaded http://localhost:46426/tests/dromaeo/cssquery-dojo.html (next: http://localhost:46426/tests/dromaeo/cssquery-ext.html) 03:13:36 INFO - PID 5059 | RSS: Main: 182669312 03:13:36 INFO - PID 5059 | 03:16:38 INFO - PID 5059 | Cycle 1(1): loaded http://localhost:46426/tests/dromaeo/cssquery-ext.html (next: http://localhost:46426/tests/dromaeo/cssquery-jquery.html) 03:16:38 INFO - PID 5059 | RSS: Main: 179978240 03:16:38 INFO - PID 5059 | 03:19:40 INFO - PID 5059 | Cycle 1(1): loaded http://localhost:46426/tests/dromaeo/cssquery-jquery.html (next: http://localhost:46426/tests/dromaeo/cssquery-mootools.html) 03:19:41 INFO - PID 5059 | RSS: Main: 181891072 03:19:41 INFO - PID 5059 | 03:22:43 INFO - PID 5059 | Cycle 1(1): loaded http://localhost:46426/tests/dromaeo/cssquery-mootools.html (next: http://localhost:46426/tests/dromaeo/cssquery-prototype.html) 03:22:43 INFO - PID 5059 | RSS: Main: 181215232 03:22:43 INFO - PID 5059 | 03:25:47 INFO - PID 5059 | Cycle 1(1): loaded http://localhost:46426/tests/dromaeo/cssquery-prototype.html (next: http://localhost:46426/tests/dromaeo/cssquery-yui.html) 03:25:48 INFO - PID 5059 | RSS: Main: 182132736 03:25:48 INFO - PID 5059 | 03:28:50 INFO - PID 5059 | Cycle 1(1): loaded http://localhost:46426/tests/dromaeo/cssquery-yui.html (next: http://localhost:46426/tests/dromaeo/cssquery-dojo.html) 03:28:50 INFO - PID 5059 | RSS: Main: 184369152 03:28:50 INFO - PID 5059 | 03:28:50 INFO - PID 5059 | __start_tp_report 03:28:50 INFO - PID 5059 | _x_x_mozilla_page_load 03:28:50 INFO - PID 5059 | _x_x_mozilla_page_load_details 03:28:50 INFO - PID 5059 | |i|pagename|runs| 03:28:50 INFO - PID 5059 | |0;dojo.html;3086.984565077175;3114.112477943785;3118.0957522318527;3124.531320301956;3144.6698096699847;5899.292084949812;5936.079907614316;5964.13520039594;5989.802039592083;6114.480269177126;5837.795677151301;5945.791897283585;5946.613470124439;5958.136070269808;5975.924333619947;5519.365272993607;5536.2249285100115;5551.528120109796;5552.333719953591;5625.5499560035305;5591.916121258164;5644.915326270109;5657.20799088128;5657.632253903504;5714.771409143629;5408.918866216971;5603.991281569336;5624.775008999635;5663.348714897798;5699.743511541969;5412.8386104649135;5531.585131115183;5544.889102217973;5611.410801865786;5623.775048998035;5518.034343989786;5554.333479982428;5567.137093750475;5630.5495560355075;5651.378348381675;5889.734961926723;5999.400059994009;6020.909686354708;6079.118527813443;6084.26988761347;6413.583117097421;6472.838179045514;6486.610803351814;6496.350364963466;6504.739810407578;6470.708818103197;6553.14809074822;6554.377334153248;6581.440577550866;6654.534182607219;5981.671008094597;6014.51883849291;6042.909356359658;6110.541709371815;6170.784022559234;6546.18172728409;6702;6739.427148692416;6778.423833974168;6791.932080679228;6358.1734374531015;6382.680865956683;6423.068655044993;6429.099926010363;6441.742330306735;6483.4164925156965;6525;6562.884309667273;6590.670466476753;6604.636744978976;6323.557350985387;6326.2724786649205;6404.71178796946;6420.935790642127;6460.450861676716;6412.845687776152;6475.579087359307;6491.285958544557;6561.934380656227;6573.276939536647;5166;5195;5251.765835028765;5293.179557168645;5298.125809241432;4408.779561021936;4506.3465797459185;4507.2788353863225;4507.5267096955;4600.5629465200755;5652.886942261214;5667.971660141673;5683.431656834284;5687.431256874363;5745.798897038583;6457.741690332334;6458.773942912069;6534.575252608565;6543.083968244449;6637.6349300788925;5561.77752889888;5624.521915637135;5651.067573850269;5694.914576281359;5695.829125126253;5699.800506982236;5772.595918285764;5783.161441590946;5795.043817770105;5801.158831969426;6330.177076979963;6333.524985626004;6397.7440902364315;6435.774747883802;6435.806925792233;6407.295197528175;6509.283978762427;6510.674466276762;6620.073189753342;6624.6025238485845;6363.649999250086;6428.903566446601;6441.838954026187;6450.193725784277;6460.741570337133;6421.454176394872;6450.064740612679;6532.5753826001155;6554;6556.868862622816;6550.574212676161;6553.389624378986;6623.072769812326;6630.46956243509;6643.368879956396;6238.656873871799;6277.748890044347;6315.5894866833505;6341.239051313872;6349.460295874717;6251.531135164972;6381.138546296376;6401.711922963571;6412.775552855627;6423.743050277936;6244.750209991549;6252.343503932204;6300.62196268207;6306.621602703853;6370.872582548416;6276.811695649138;6303.49572034227;6356.396142366468;6362.618242905441;6371.012493063583;6207.720652570555;6234.688265586793;6254.312025677263;6261.092141639346;6265.749370025148 03:28:50 INFO - PID 5059 | |1;ext.html;770.9383249340053;822.2681813186264;843.7426584891607;845.2181731897992;1101.5648818716613;29695.25761855952;40728.18543629129;41697.166056678885;41745.373819392735;41791;42114.36828447576;42480.3627945581;42482.787586062026;42529;42566.57433425665;7170.247124051978;7446.962765186194;7536.133344665365;7886.053673559181;7890.526568405885;7667.616619169047;7737.07155141381;7755.418343624251;7770.533767973911;7771.611419429034;7707.421943354243;7762.8447431051345;7775.455718099707;7783.104942931551;7792.805179870492;7728.26581474759;7728.459007869451;7729.497582657165;7777.261160189773;7782.299593036597;7698.653560589787;7724.30481256684;7734.961325193394;7762.844743105106;7785.4939428937505;38685;38966.22067558633;39013.21973560541;39029.80485097556;39050.80474597637;3519.577650681909;3592.3354179476883;3602.0274525878126;3613;3613.692836108934;31272;31286.530702039487;31429.685703142906;31442.685573144205;31456.842715786504;4837.9516204837855;4918.5573298403315;4922.827701030446;4947.109520286347;4952.455229924705;193817;195183;195593;196546.01726991415;197298;48128.5187148131;48176.27735583969;48182.75908620505;48263.75868120637;48265;50341;50802;50890.236646450336;51022.48977510251;51077;15841.128737919526;16172.272247748879;16191.75712364292;16231.107289098976;16282.267297971619;11542;11712.88287117135;12602.621921342374;13277.867221327662;13311.534096306776;13357.198568085945;13432.059755817;13533.932330338483;13644.522441714493;13713.520026799015;5326;5390.407055223922;5495.725213739297;5547.889042219133;5556.138798486241;983.4836710726926;987.2842189412762;990.5047476261869;1017.862588550551;1033.6330602635956;22575.435614109778;22614.321570352917;22674.773252267598;23283.7671623285;23295;1076.7900259449332;1086.9945650271698;1105.8120119579692;1117.9776404472027;1120.372591348831;11829.940850295694;11999.940000299943;12140.332281724413;12183.878161218452;12217.877821221851;221430;222474;222931;223016;224060;53775.73112134414;53940.46059539433;54109.72945135249;54214;54652;1458.6499240182493;1463.604826696786;1496.835348111707;1500.6398464368692;1505.503183949316;21917.232896848534;22112.11551537985;22725.204617838295;23032.193873215027;23075.076996919935;48138.75930620325;50851;50869.74565127151;50930;51132.74433627808;195594;196612;197094;197150;197259;31208.37583248277;31942.840285798422;33908.66091339055;34246;34743.47884781781;44744.77627611841;46688.29967550557;47008.52991470179;47296.763516182196;47791.28313075376;32025.839870800497;33661.83169084139;33766.32467350688;33797.49303760396;33919.15202119868;32247.35505289834;32694.34611307808;33828;34134.317313654086;34550.13624659403;36756.264874701825;37661;37954.81022594869;38077;38149.4277585842;30427.2393190172;32177.83911080523;32363.67636323701;32484.675153248165;32529.674703252665;22590.548189036457;24286.392840179138;24316.878415608517;24419.38951526226;24561.877190613934 03:28:50 INFO - PID 5059 | |2;jquery.html;576.2508738639767;581.2008488328547;581.6451964301777;585.3853453873431;613.6348872420909;15995.120268385233;21582.244621438254;22661.320160395193;22667.09331626733;22680.659790103142;17063.232154553043;19179.232830686757;20911.37265882026;20927.058282377293;21048.158073677074;6049;6215.502759779207;6276.843078923018;6330.050492426127;6331.335209802974;5637.210790489335;6162.969185154068;6166.7533298667995;6258.374162583728;6333.334999825021;6243.594166379194;6251.624902505841;6252.718192770471;6261.27995280544;6276.246850377961;6257.217847769029;6262.655553944532;6273.12176295319;6274.811755647338;6278.529110316745;5774.5091667208335;5808.12878068289;5851.736671849777;5861.150133230701;5878.676672782995;26228.213153605422;27834.443311133666;28377.290567735767;28514.429711405657;28535.71464285372;1884.5006073390425;1923.0673123535214;1924.6728056230475;1927.180948097053;1929.4790406590282;17656.293748250184;18128.728069078974;18165.636687266182;18175.363862264756;18326.725099123523;2246.595612789697;2265.9433514162115;2285.748567657556;2308.1575225042907;2323.6630688550067;136367;139834.90247646294;139861;140170.29914850462;140304;13786.241756703277;14515.346809393603;14638.53614638549;14655;14743.557693269218;22634.320970370914;22676.433089172573;22700.205492807672;22816;22858.657120143213;9801;9822.607095716092;9932.900670993198;9987.900120998696;10136.0877521022;9050.592723327467;9123.36136470454;9152.725418237464;9204.125608067223;9319.90680093204;8848.690295839744;10863.239573229797;11110.55557777696;11341.773164536664;11862.644120676394;3573.76770509916;3864.7487913285545;3930.606939306104;4446.866594002185;4586.4496260448295;948.3569447896407;952.2096659772373;954.1889394015031;989.5101924547395;991.7619771254991;18680.439586812146;19108.426747197605;21873.453163671034;23508.764912351;23617.527649446914;1022.4070039377143;1034.0216906848968;1071.4374953149659;1073.0342691577487;1076.160594736107;10547.894521054845;10981.956714112306;11028.44857757109;11080;11266.54933802655;453797;475719;478923;480615;482076;116656.41671791587;117371.41314293545;118609.40695296641;120521;122898;1276.9170003949898;1277.4570807406815;1294.5598496511043;1294.9158304710163;1303.2310936547483;16391.180440978143;20125.295614653416;20809;20842.68735968992;20863.582728345045;55832;56024;56976;57700.42299577119;58159.4184058154;63751.6812415935;65219;65242;65704;65923.67038164778;12099.81850272229;12576.685582860502;12591.370431478206;14208.857911420753;14750.188739619423;22393.552128957002;22992.310230693107;23212.3036308911;23309;23363.415914602272;18099.81900181034;18175.363862265287;18328;18337.266509339475;18368.724469132707;16405.343786248894;16557.960346729116;16780.74828877592;17184.054876981885;17253.913730431268;18364.255395737382;18471.35350262788;18671.15979780886;18686.06569671484;18932.337368192046;14177.007609467239;14206.07660502064;14243.145411275356;14273.857261427253;14320.713585728436;18189.909050454662;18204.99872506972;18311.633767324845;18372.54068648241;18605.720914186026 03:28:50 INFO - PID 5059 | |3;mootools.html;1360.1770928588203;1406.507722297196;1429.9928500357496;1432.2838580709645;1435.1460880775942;12119;13544.932275338622;14060.29698515074;14133;14199.361028753705;12187.08596855235;12329.260244385321;13264.403101860415;13908.791368129487;13914.234717090581;2690.5964105384155;2767.266674331294;2769.4461107778425;2773.1403264987816;2773.62556054932;2630.487055024271;2711.281510399736;2718.0350975403744;2728.358835673615;2731.3581308392513;2647.761701446869;2689.0453888869465;2693.8383696978244;2693.946121077577;2695.0567301444535;2579.20044786116;2602.58358662614;2606.4656745367342;2614.307208589725;2615.712271650117;2554.463562651845;2556.5398228318895;2560.6799150106235;2562.5131225067175;2566.0377358490564;13461.394237259346;13537.578554251859;13538;13570.728585428335;13581.185128892299;7113.92886071143;7330.743423980189;7345.55926644403;7363.410927125817;7367.373773229282;4613.861584152447;4852.8301509447;5043.344365232533;5059.848204553869;5064.139096353629;1858.721191821224;1866.5333666583354;1870.0743132149537;1894.7494653528743;1907.1322548240516;21758.564828703496;21991.120355185933;22133.778662213495;22249.66625500619;22318.776812231834;6877.552959057645;7085.92914070863;7114.608696521637;7134.92865071353;7157.856842863113;15599.844001560066;15734.68530629381;15768.132752698482;15802.446914357943;15806.288717007763;7410.555366678017;7645.847083058307;7652.65563049653;7663.655135518915;7676.80807979805;5796.478316951495;5830.5044071254415;6070.271567411851;6156.384361563808;6158.107074474176;5049.974750126225;5162.6128040397125;5268.28878101459;5291.1798671206025;5307.946920530822;1489.7244009858211;1519.1492764052166;1525.7711343298595;1539.1380826737063;1539.7151526967548;862.784303924019;868.5830801215452;869.7825543614097;895.9462432254086;904.7376260884402;7083.362497375261;7112.03987461686;7125.180604230476;7202.099737532809;7238.420926325882;659.4691273524859;671.177807186193;689.9344562266576;690.7547820523641;692.62944324786;4123.092919557693;4537.6143027843;4913.361263035782;5019.437970665887;5081.364829396325;17865.7320140198;19510.804891951182;19515.316963906196;19536.902315488616;19546.511337216398;18785.81214187868;19005.80994190068;19109.80890191108;19184.90407547953;19342.226310947404;9681.789776277965;10271.794564108675;10289.125424338865;10293.74265643365;10356.533955972;7365.52124111931;7473.51422157558;7610.8097297568;7665.8466830661955;7720.073591169095;16058.8394116062;16404.835951640332;16760.32958681688;16797.91601041987;16892.66214675724;16441.83558164403;16542.33830646809;16836.326546938475;16875.240614172148;17179.14104294755;10329.276950613685;10497.2127090467;10497.580096796348;10498.212634052325;10512.684619461428;13084.214947103204;13576.93211533936;13589.660258493617;13594.048416610742;13600.727985440433;10519.211059170746;10990.780184396428;11062.22564420483;11081.667549973514;11407.828882566602;10064.079530482646;10621.415822129857;10743.355398676105;10782.460876955964;10962.835557466486;9208.815823683623;9400.670976515788;9406.341556091007;9476.052394760469;9525.904740952501;6825.2833452486775;7181.820454488679;7292.489525733148;7319.121705395387;7330.890036649348;7029.5430796998035;7075.646217688992;7080.520829172956;7113.3953613943395;7191.993120962965 03:28:50 INFO - PID 5059 | |4;prototype.html;483.2871514516087;496.1837776857069;511.5242824173522;520.0742678033101;522.4879617974385;6082.695865206739;6088.208532890723;6124.938750612492;6215.59598626089;6273.3412991635905;5823.2138661280715;5957.7021148942595;5976.223090998175;5987.7604895804225;6076.908846367308;4821.156297647915;4832.661713680044;4856.854294371157;4870.220764677652;4874.295535393109;4685.672002959795;4767.809287628508;4809.254565542346;4812.542808433193;4880.9755951220195;4770.332153498513;4847.806087756486;4850.248211527219;4861.368022157115;4887.266909963516;4837.419509658828;4901.65688401812;4906.558409743105;4926.704397736147;4935.629827762932;4380.474343078851;4391.377113881061;4394.8901277468;4408.977955110236;4431.246688063037;6006.699665016732;6014.368491308437;6036.852997930423;6040.516758659341;6044.576879618428;5569.164625306196;5582.972085139589;5635.211070450099;5636.859078523029;5641.125625528009;6431.131797207364;6436.90800489838;6461.870762584769;6469.805905822833;6474.482041436674;4692.41344831896;4757.715416837469;4820.228763397839;4835;4846.5880400166025;6696.2968888267005;6729.293424190488;6809.319068093151;6815.7614483493335;6863.176418829772;4840.854774356775;4857.854264372075;4872.14737420957;4898.657094003457;4919.434265059493;5007.24891266313;5014.423341315795;5053.67151135175;5059.610061258892;5060.746962651852;5546.4453554644215;5623.184638227516;5669.31968163823;5682.403347648437;5729.8567535811935;6174.351693072253;6312.936870631327;6380.3619638035825;6407.7436902524305;6495.382938620824;1626.682796854602;1678.152532970842;1682.8990260584403;1711.0674682298177;1742.5469377961567;1177.7997740383985;1188.9643310700692;1198.4487135917575;1206.7646808872362;1218.79889818179;5597.244372009726;5641.9533451935495;5687.857803554862;5700.23046888673;5756.539476841843;6406.391392817675;6464.353564643498;6559.180102487189;6597.505187110986;6642.568233064835;5660.15097735343;5674.77300907959;5674.801381951612;5711.029694755386;5722.484976352065;3463.4631632097066;3493.6681015303507;3502.824858757052;3546.361654902142;3551.751377403609;6403.359664033559;6403.97536394184;6442.35576442352;6458.5479016469335;6462.256840463313;6724.798256052326;6734.521543173734;6751.25736169021;6807.625580593115;6836.623985680835;6342.873142537216;6346.428821406095;6350.65071421067;6361.363863613694;6381.3937675920715;6403.0715546246465;6504.219493660791;6603.273639899511;6637.0420725885015;6641.269460359454;6528.771492997912;6546.279909209888;6564.80305590833;6567.31043240472;6612.570182938093;6345.270293916259;6358.745650173942;6422.839429014312;6455.903161452488;6477.352264773674;4907.975460122677;4911.901761964812;4949.282354058713;4954.157793175097;4979.377577802775;6415.615063096229;6588.439982601532;6610.603363798187;6630.149035914603;6661.700223489857;6279.780207692709;6351.078503888263;6424;6445.806625801233;6452.548321617442;6279.780207692892;6332.556721029484;6398.648074355955;6476.676166191577;6490.3185165558825;6245.96877015612;6321.462675672619;6338.809835704937;6341.55609107358;6358.332375100548;6170.259568851767;6286.52851036165;6291;6376.266729326001;6396.520260980352;6201.410865967726;6238.968805155945;6245.375462453719;6251.906221406592;6268.780592679234 03:28:50 INFO - PID 5059 | |5;yui.html;898.416029580772;911.7811725185954;921.433318509117;925.4678559828101;935.4574346878811;17600.383986560457;18543.629127417444;18581.72127418088;18773.62452750944;21408.46478838026;20898.582028359422;21644.134234630597;21782.673259901116;21791;21967.890160549174;977.9217662586976;995.1889210293588;1004.372267332917;1004.5780772075709;1006.1598565198068;962.3263715399214;1053.8208504554243;1058.0477570186854;1059.7350662334416;1061.1828891753346;1108.362691452414;1111.1000089927145;1113.838493418454;1114.0753174864883;1114.5486078138326;1108.7505311304933;1109.4563663804677;1110.8666959964776;1111.794318051159;1114.1977776001265;804.6137853830194;808.6684459371688;813.5078277642001;816.2286639126029;823.7487566292278;17228.827711722846;17616.91191544034;17624.325689059646;17663.205155767893;20203.696944545845;20127.79872201274;20319.18723251068;20951.68572471414;20985.685214721638;21229.044692988853;15724.921375393164;15817.920910395374;15841.049537027815;15872.92063539675;16418.932769370072;3555.5022296878456;3578.320119177348;3580.051286409104;3582.3193593217206;3586.4799604057525;118110;120113;123501;124757.37621311926;127739;15392.846071539365;15827.52517424479;16316.836831631768;16321.714959905623;16330.836691632932;29524.557131643043;29799.851000744857;29881.850590746908;30196.24509387239;30368;8423.831523369621;8461.788455288544;8505.61724722389;8511.404201705822;8541.231289184003;4012.0972781124597;4087.202995415865;4127;4130.690198235085;4136.689748268892;5020.723860187724;5032.6980381177245;5085.7202853842655;5112.284280200774;5169.198774190007;940.7083804020639;951.1534734086669;953.880764904387;954.9972528844825;956.0391806234828;670.4301343857682;673.1417442760519;683.1221879884325;712.7113519024804;717.6304203335286;11380.544778208945;11883.742089003063;11890.464929078213;11976.52093916251;12518.561850335194;623.7006237006262;643.9227292724903;662.3773652766384;666.8832954232989;678.5080816408065;5089.592832573459;5102.902875881629;5675.5459563234845;5918.763249470059;6079.756809727562;94731.52634236784;98270;98446.50776746214;99017;101743;86162;86934.56532717295;87809;90452;91640;74153.25846741571;75920;75965.6201718999;76043.23956760472;78720;11848.466818992994;12375.071869609996;12553.121281510206;12556;12923.28921909304;32688.673113269513;34103.218516209556;35132.94601161969;35350.64649353473;38017.429738553394;62596.374036259054;63553;65202;66076;67573.66213168902;18961.336353227573;19112;19136.808631913504;19195.232190712217;19314.13086411143;20538.589228215053;21179.68230476575;21229.787702123398;21440;21814.345569632937;16871.83128168752;17499.38752143669;17685.292588296325;18076;18148.909255453636;16430.424935127212;16510.917445412695;16639.50081497557;16689.332426702797;16723.74914376261;18453.53866153303;18510.629787404447;18816.435506934813;18889.90555047216;19341.226350945806;13064;13323.13399629021;14279.71440571162;14489.855101448851;14679.55961321162;14116.223607701675;14402.20787856678;14492.782608261095;14712.190829504052;14843.851561484678 03:28:50 INFO - PID 5059 | __end_tp_report 03:28:50 INFO - PID 5059 | __start_cc_report 03:28:50 INFO - PID 5059 | _x_x_mozilla_cycle_collect,388 03:28:50 INFO - PID 5059 | __end_cc_report 03:28:50 INFO - PID 5059 | __startTimestamp1500719330287__endTimestamp 03:28:50 INFO - PID 5059 | 03:28:50 INFO - PID 5059 | ------- Summary: start ------- 03:28:50 INFO - PID 5059 | Number of tests: 6 03:28:50 INFO - PID 5059 | 03:28:50 INFO - PID 5059 | [#0] dojo.html Cycles:165 Average:6000.97 Median:6261.09 stddev:704.55 (11.3%) stddev-sans-first:668.60 03:28:50 INFO - PID 5059 | Values: 3087.0 3114.1 3118.1 3124.5 3144.7 5899.3 5936.1 5964.1 5989.8 6114.5 5837.8 5945.8 5946.6 5958.1 5975.9 5519.4 5536.2 5551.5 5552.3 5625.5 5591.9 5644.9 5657.2 5657.6 5714.8 5408.9 5604.0 5624.8 5663.3 5699.7 5412.8 5531.6 5544.9 5611.4 5623.8 5518.0 5554.3 5567.1 5630.5 5651.4 5889.7 5999.4 6020.9 6079.1 6084.3 6413.6 6472.8 6486.6 6496.4 6504.7 6470.7 6553.1 6554.4 6581.4 6654.5 5981.7 6014.5 6042.9 6110.5 6170.8 6546.2 6702.0 6739.4 6778.4 6791.9 6358.2 6382.7 6423.1 6429.1 6441.7 6483.4 6525.0 6562.9 6590.7 6604.6 6323.6 6326.3 6404.7 6420.9 6460.5 6412.8 6475.6 6491.3 6561.9 6573.3 5166.0 5195.0 5251.8 5293.2 5298.1 4408.8 4506.3 4507.3 4507.5 4600.6 5652.9 5668.0 5683.4 5687.4 5745.8 6457.7 6458.8 6534.6 6543.1 6637.6 5561.8 5624.5 5651.1 5694.9 5695.8 5699.8 5772.6 5783.2 5795.0 5801.2 6330.2 6333.5 6397.7 6435.8 6435.8 6407.3 6509.3 6510.7 6620.1 6624.6 6363.6 6428.9 6441.8 6450.2 6460.7 6421.5 6450.1 6532.6 6554.0 6556.9 6550.6 6553.4 6623.1 6630.5 6643.4 6238.7 6277.7 6315.6 6341.2 6349.5 6251.5 6381.1 6401.7 6412.8 6423.7 6244.8 6252.3 6300.6 6306.6 6370.9 6276.8 6303.5 6356.4 6362.6 6371.0 6207.7 6234.7 6254.3 6261.1 6265.7 03:28:50 INFO - PID 5059 | 03:28:50 INFO - PID 5059 | [#1] ext.html Cycles:180 Average:37999.10 Median:3597.18 stddev:53270.50 (1480.9%) stddev-sans-first:53346.59 03:28:50 INFO - PID 5059 | Values: 770.9 822.3 843.7 845.2 1101.6 29695.3 40728.2 41697.2 41745.4 41791.0 42114.4 42480.4 42482.8 42529.0 42566.6 7170.2 7447.0 7536.1 7886.1 7890.5 7667.6 7737.1 7755.4 7770.5 7771.6 7707.4 7762.8 7775.5 7783.1 7792.8 7728.3 7728.5 7729.5 7777.3 7782.3 7698.7 7724.3 7735.0 7762.8 7785.5 38685.0 38966.2 39013.2 39029.8 39050.8 3519.6 3592.3 3602.0 3613.0 3613.7 31272.0 31286.5 31429.7 31442.7 31456.8 4838.0 4918.6 4922.8 4947.1 4952.5 193817.0 195183.0 195593.0 196546.0 197298.0 48128.5 48176.3 48182.8 48263.8 48265.0 50341.0 50802.0 50890.2 51022.5 51077.0 15841.1 16172.3 16191.8 16231.1 16282.3 11542.0 11712.9 12602.6 13277.9 13311.5 13357.2 13432.1 13533.9 13644.5 13713.5 5326.0 5390.4 5495.7 5547.9 5556.1 983.5 987.3 990.5 1017.9 1033.6 22575.4 22614.3 22674.8 23283.8 23295.0 1076.8 1087.0 1105.8 1118.0 1120.4 11829.9 11999.9 12140.3 12183.9 12217.9 221430.0 222474.0 222931.0 223016.0 224060.0 53775.7 53940.5 54109.7 54214.0 54652.0 1458.6 1463.6 1496.8 1500.6 1505.5 21917.2 22112.1 22725.2 23032.2 23075.1 48138.8 50851.0 50869.7 50930.0 51132.7 195594.0 196612.0 197094.0 197150.0 197259.0 31208.4 31942.8 33908.7 34246.0 34743.5 44744.8 46688.3 47008.5 47296.8 47791.3 32025.8 33661.8 33766.3 33797.5 33919.2 32247.4 32694.3 33828.0 34134.3 34550.1 36756.3 37661.0 37954.8 38077.0 38149.4 30427.2 32177.8 32363.7 32484.7 32529.7 22590.5 24286.4 24316.9 24419.4 24561.9 03:28:50 INFO - PID 5059 | 03:28:50 INFO - PID 5059 | [#2] jquery.html Cycles:180 Average:34070.71 Median:12320.07 stddev:80277.68 (651.6%) stddev-sans-first:80463.49 03:28:50 INFO - PID 5059 | Values: 576.3 581.2 581.6 585.4 613.6 15995.1 21582.2 22661.3 22667.1 22680.7 17063.2 19179.2 20911.4 20927.1 21048.2 6049.0 6215.5 6276.8 6330.1 6331.3 5637.2 6163.0 6166.8 6258.4 6333.3 6243.6 6251.6 6252.7 6261.3 6276.2 6257.2 6262.7 6273.1 6274.8 6278.5 5774.5 5808.1 5851.7 5861.2 5878.7 26228.2 27834.4 28377.3 28514.4 28535.7 1884.5 1923.1 1924.7 1927.2 1929.5 17656.3 18128.7 18165.6 18175.4 18326.7 2246.6 2265.9 2285.7 2308.2 2323.7 136367.0 139834.9 139861.0 140170.3 140304.0 13786.2 14515.3 14638.5 14655.0 14743.6 22634.3 22676.4 22700.2 22816.0 22858.7 9801.0 9822.6 9932.9 9987.9 10136.1 9050.6 9123.4 9152.7 9204.1 9319.9 8848.7 10863.2 11110.6 11341.8 11862.6 3573.8 3864.7 3930.6 4446.9 4586.4 948.4 952.2 954.2 989.5 991.8 18680.4 19108.4 21873.5 23508.8 23617.5 1022.4 1034.0 1071.4 1073.0 1076.2 10547.9 10982.0 11028.4 11080.0 11266.5 453797.0 475719.0 478923.0 480615.0 482076.0 116656.4 117371.4 118609.4 120521.0 122898.0 1276.9 1277.5 1294.6 1294.9 1303.2 16391.2 20125.3 20809.0 20842.7 20863.6 55832.0 56024.0 56976.0 57700.4 58159.4 63751.7 65219.0 65242.0 65704.0 65923.7 12099.8 12576.7 12591.4 14208.9 14750.2 22393.6 22992.3 23212.3 23309.0 23363.4 18099.8 18175.4 18328.0 18337.3 18368.7 16405.3 16558.0 16780.7 17184.1 17253.9 18364.3 18471.4 18671.2 18686.1 18932.3 14177.0 14206.1 14243.1 14273.9 14320.7 18189.9 18205.0 18311.6 18372.5 18605.7 03:28:50 INFO - PID 5059 | 03:28:50 INFO - PID 5059 | [#3] mootools.html Cycles:180 Average:8513.47 Median:2604.52 stddev:5796.74 (222.6%) stddev-sans-first:5788.08 03:28:50 INFO - PID 5059 | Values: 1360.2 1406.5 1430.0 1432.3 1435.1 12119.0 13544.9 14060.3 14133.0 14199.4 12187.1 12329.3 13264.4 13908.8 13914.2 2690.6 2767.3 2769.4 2773.1 2773.6 2630.5 2711.3 2718.0 2728.4 2731.4 2647.8 2689.0 2693.8 2693.9 2695.1 2579.2 2602.6 2606.5 2614.3 2615.7 2554.5 2556.5 2560.7 2562.5 2566.0 13461.4 13537.6 13538.0 13570.7 13581.2 7113.9 7330.7 7345.6 7363.4 7367.4 4613.9 4852.8 5043.3 5059.8 5064.1 1858.7 1866.5 1870.1 1894.7 1907.1 21758.6 21991.1 22133.8 22249.7 22318.8 6877.6 7085.9 7114.6 7134.9 7157.9 15599.8 15734.7 15768.1 15802.4 15806.3 7410.6 7645.8 7652.7 7663.7 7676.8 5796.5 5830.5 6070.3 6156.4 6158.1 5050.0 5162.6 5268.3 5291.2 5307.9 1489.7 1519.1 1525.8 1539.1 1539.7 862.8 868.6 869.8 895.9 904.7 7083.4 7112.0 7125.2 7202.1 7238.4 659.5 671.2 689.9 690.8 692.6 4123.1 4537.6 4913.4 5019.4 5081.4 17865.7 19510.8 19515.3 19536.9 19546.5 18785.8 19005.8 19109.8 19184.9 19342.2 9681.8 10271.8 10289.1 10293.7 10356.5 7365.5 7473.5 7610.8 7665.8 7720.1 16058.8 16404.8 16760.3 16797.9 16892.7 16441.8 16542.3 16836.3 16875.2 17179.1 10329.3 10497.2 10497.6 10498.2 10512.7 13084.2 13576.9 13589.7 13594.0 13600.7 10519.2 10990.8 11062.2 11081.7 11407.8 10064.1 10621.4 10743.4 10782.5 10962.8 9208.8 9400.7 9406.3 9476.1 9525.9 6825.3 7181.8 7292.5 7319.1 7330.9 7029.5 7075.6 7080.5 7113.4 7192.0 03:28:50 INFO - PID 5059 | 03:28:50 INFO - PID 5059 | [#4] prototype.html Cycles:180 Average:5404.87 Median:6025.61 stddev:1516.73 (25.2%) stddev-sans-first:1475.32 03:28:50 INFO - PID 5059 | Values: 483.3 496.2 511.5 520.1 522.5 6082.7 6088.2 6124.9 6215.6 6273.3 5823.2 5957.7 5976.2 5987.8 6076.9 4821.2 4832.7 4856.9 4870.2 4874.3 4685.7 4767.8 4809.3 4812.5 4881.0 4770.3 4847.8 4850.2 4861.4 4887.3 4837.4 4901.7 4906.6 4926.7 4935.6 4380.5 4391.4 4394.9 4409.0 4431.2 6006.7 6014.4 6036.9 6040.5 6044.6 5569.2 5583.0 5635.2 5636.9 5641.1 6431.1 6436.9 6461.9 6469.8 6474.5 4692.4 4757.7 4820.2 4835.0 4846.6 6696.3 6729.3 6809.3 6815.8 6863.2 4840.9 4857.9 4872.1 4898.7 4919.4 5007.2 5014.4 5053.7 5059.6 5060.7 5546.4 5623.2 5669.3 5682.4 5729.9 6174.4 6312.9 6380.4 6407.7 6495.4 1626.7 1678.2 1682.9 1711.1 1742.5 1177.8 1189.0 1198.4 1206.8 1218.8 5597.2 5642.0 5687.9 5700.2 5756.5 6406.4 6464.4 6559.2 6597.5 6642.6 5660.2 5674.8 5674.8 5711.0 5722.5 3463.5 3493.7 3502.8 3546.4 3551.8 6403.4 6404.0 6442.4 6458.5 6462.3 6724.8 6734.5 6751.3 6807.6 6836.6 6342.9 6346.4 6350.7 6361.4 6381.4 6403.1 6504.2 6603.3 6637.0 6641.3 6528.8 6546.3 6564.8 6567.3 6612.6 6345.3 6358.7 6422.8 6455.9 6477.4 4908.0 4911.9 4949.3 4954.2 4979.4 6415.6 6588.4 6610.6 6630.1 6661.7 6279.8 6351.1 6424.0 6445.8 6452.5 6279.8 6332.6 6398.6 6476.7 6490.3 6246.0 6321.5 6338.8 6341.6 6358.3 6170.3 6286.5 6291.0 6376.3 6396.5 6201.4 6239.0 6245.4 6251.9 6268.8 03:28:50 INFO - PID 5059 | 03:28:50 INFO - PID 5059 | [#5] yui.html Cycles:180 Average:22467.64 Median:21319.13 stddev:29600.31 (138.8%) stddev-sans-first:29639.04 03:28:50 INFO - PID 5059 | Values: 898.4 911.8 921.4 925.5 935.5 17600.4 18543.6 18581.7 18773.6 21408.5 20898.6 21644.1 21782.7 21791.0 21967.9 977.9 995.2 1004.4 1004.6 1006.2 962.3 1053.8 1058.0 1059.7 1061.2 1108.4 1111.1 1113.8 1114.1 1114.5 1108.8 1109.5 1110.9 1111.8 1114.2 804.6 808.7 813.5 816.2 823.7 17228.8 17616.9 17624.3 17663.2 20203.7 20127.8 20319.2 20951.7 20985.7 21229.0 15724.9 15817.9 15841.0 15872.9 16418.9 3555.5 3578.3 3580.1 3582.3 3586.5 118110.0 120113.0 123501.0 124757.4 127739.0 15392.8 15827.5 16316.8 16321.7 16330.8 29524.6 29799.9 29881.9 30196.2 30368.0 8423.8 8461.8 8505.6 8511.4 8541.2 4012.1 4087.2 4127.0 4130.7 4136.7 5020.7 5032.7 5085.7 5112.3 5169.2 940.7 951.2 953.9 955.0 956.0 670.4 673.1 683.1 712.7 717.6 11380.5 11883.7 11890.5 11976.5 12518.6 623.7 643.9 662.4 666.9 678.5 5089.6 5102.9 5675.5 5918.8 6079.8 94731.5 98270.0 98446.5 99017.0 101743.0 86162.0 86934.6 87809.0 90452.0 91640.0 74153.3 75920.0 75965.6 76043.2 78720.0 11848.5 12375.1 12553.1 12556.0 12923.3 32688.7 34103.2 35132.9 35350.6 38017.4 62596.4 63553.0 65202.0 66076.0 67573.7 18961.3 19112.0 19136.8 19195.2 19314.1 20538.6 21179.7 21229.8 21440.0 21814.3 16871.8 17499.4 17685.3 18076.0 18148.9 16430.4 16510.9 16639.5 16689.3 16723.7 18453.5 18510.6 18816.4 18889.9 19341.2 13064.0 13323.1 14279.7 14489.9 14679.6 14116.2 14402.2 14492.8 14712.2 14843.9 03:28:50 INFO - PID 5059 | -------- Summary: end -------- 03:28:50 INFO - PID 5059 | 03:28:51 INFO - TEST-INFO | 5059: exit 0 03:28:51 INFO - TEST-OK | dromaeo_css | took 1113832ms 03:28:51 INFO - TEST-START | kraken 03:28:51 INFO - Initialising browser for kraken test... 03:28:51 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:46426/getInfo.html -profile /tmp/tmprhQQbl/profile 03:28:51 INFO - TEST-INFO | started process 5439 (/builds/slave/test/build/application/firefox/firefox http://localhost:46426/getInfo.html) 03:28:57 INFO - TEST-INFO | 5439: exit 0 03:28:57 INFO - Browser initialized. 03:28:57 INFO - Running cycle 1/1 for kraken test... 03:28:57 INFO - TEST-INFO | started process 5670 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmprhQQbl/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 03:29:09 INFO - PID 5670 | RSS: Main: 176766976 03:29:09 INFO - PID 5670 | 03:29:11 INFO - PID 5670 | Cycle 1(1): loaded http://localhost:46426/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:46426/tests/kraken/driver.html?testName=audio-beat-detection) 03:29:12 INFO - PID 5670 | RSS: Main: 180948992 03:29:12 INFO - PID 5670 | 03:29:15 INFO - PID 5670 | Cycle 1(1): loaded http://localhost:46426/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:46426/tests/kraken/driver.html?testName=audio-dft) 03:29:15 INFO - PID 5670 | RSS: Main: 181596160 03:29:15 INFO - PID 5670 | 03:29:18 INFO - PID 5670 | Cycle 1(1): loaded http://localhost:46426/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:46426/tests/kraken/driver.html?testName=audio-fft) 03:29:19 INFO - PID 5670 | RSS: Main: 176136192 03:29:19 INFO - PID 5670 | 03:29:21 INFO - PID 5670 | Cycle 1(1): loaded http://localhost:46426/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:46426/tests/kraken/driver.html?testName=audio-oscillator) 03:29:22 INFO - PID 5670 | RSS: Main: 176807936 03:29:22 INFO - PID 5670 | 03:29:24 INFO - PID 5670 | Cycle 1(1): loaded http://localhost:46426/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:46426/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:29:25 INFO - PID 5670 | RSS: Main: 176807936 03:29:25 INFO - PID 5670 | 03:29:28 INFO - PID 5670 | Cycle 1(1): loaded http://localhost:46426/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:46426/tests/kraken/driver.html?testName=imaging-darkroom) 03:29:28 INFO - PID 5670 | RSS: Main: 179519488 03:29:28 INFO - PID 5670 | 03:29:32 INFO - PID 5670 | Cycle 1(1): loaded http://localhost:46426/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:46426/tests/kraken/driver.html?testName=imaging-desaturate) 03:29:33 INFO - PID 5670 | RSS: Main: 179630080 03:29:33 INFO - PID 5670 | 03:29:35 INFO - PID 5670 | Cycle 1(1): loaded http://localhost:46426/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:46426/tests/kraken/driver.html?testName=json-parse-financial) 03:29:36 INFO - PID 5670 | RSS: Main: 180252672 03:29:36 INFO - PID 5670 | 03:29:38 INFO - PID 5670 | Cycle 1(1): loaded http://localhost:46426/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:46426/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:29:38 INFO - PID 5670 | RSS: Main: 180879360 03:29:38 INFO - PID 5670 | 03:29:40 INFO - PID 5670 | Cycle 1(1): loaded http://localhost:46426/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:46426/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:29:41 INFO - PID 5670 | RSS: Main: 180711424 03:29:41 INFO - PID 5670 | 03:29:43 INFO - PID 5670 | Cycle 1(1): loaded http://localhost:46426/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:46426/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:29:43 INFO - PID 5670 | RSS: Main: 180613120 03:29:43 INFO - PID 5670 | 03:29:46 INFO - PID 5670 | Cycle 1(1): loaded http://localhost:46426/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:46426/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:29:47 INFO - PID 5670 | RSS: Main: 180850688 03:29:47 INFO - PID 5670 | 03:29:50 INFO - PID 5670 | Cycle 1(1): loaded http://localhost:46426/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:46426/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:29:51 INFO - PID 5670 | RSS: Main: 180830208 03:29:51 INFO - PID 5670 | 03:29:52 INFO - PID 5670 | Cycle 1(1): loaded http://localhost:46426/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:46426/tests/kraken/driver.html?testName=ai-astar) 03:29:53 INFO - PID 5670 | RSS: Main: 182583296 03:29:53 INFO - PID 5670 | 03:29:53 INFO - PID 5670 | __start_tp_report 03:29:53 INFO - PID 5670 | _x_x_mozilla_page_load 03:29:53 INFO - PID 5670 | _x_x_mozilla_page_load_details 03:29:53 INFO - PID 5670 | |i|pagename|runs| 03:29:53 INFO - PID 5670 | |0;ai-astar;100;108;107;109;110;110;111;101;110;112 03:29:53 INFO - PID 5670 | |1;audio-beat-detection;150;117;139;185;119;147;148;119;185;117 03:29:53 INFO - PID 5670 | |2;audio-dft;163;162;163;163;162;162;169;168;165;163 03:29:53 INFO - PID 5670 | |3;audio-fft;75;77;78;182;88;76;75;76;160;77 03:29:53 INFO - PID 5670 | |4;audio-oscillator;80;83;140;81;81;80;132;81;81;127 03:29:53 INFO - PID 5670 | |5;imaging-gaussian-blur;117;114;114;114;113;114;113;114;113;120 03:29:53 INFO - PID 5670 | |6;imaging-darkroom;151;150;150;151;150;151;150;151;151;151 03:29:53 INFO - PID 5670 | |7;imaging-desaturate;94;94;95;94;95;94;94;98;100;94 03:29:53 INFO - PID 5670 | |8;json-parse-financial;55;54;54;54;54;55;55;55;54;54 03:29:53 INFO - PID 5670 | |9;json-stringify-tinderbox;59;54;55;54;54;54;55;55;54;56 03:29:53 INFO - PID 5670 | |10;stanford-crypto-aes;77;78;78;77;80;81;78;79;77;78 03:29:53 INFO - PID 5670 | |11;stanford-crypto-ccm;158;135;134;125;137;139;124;126;126;164 03:29:53 INFO - PID 5670 | |12;stanford-crypto-pbkdf2;178;178;178;197;183;179;182;176;186;175 03:29:53 INFO - PID 5670 | |13;stanford-crypto-sha256-iterative;68;70;72;70;70;68;69;68;72;67 03:29:53 INFO - PID 5670 | __end_tp_report 03:29:53 INFO - PID 5670 | __start_cc_report 03:29:53 INFO - PID 5670 | _x_x_mozilla_cycle_collect,993 03:29:53 INFO - PID 5670 | __end_cc_report 03:29:53 INFO - PID 5670 | __startTimestamp1500719393229__endTimestamp 03:29:53 INFO - PID 5670 | 03:29:53 INFO - PID 5670 | ------- Summary: start ------- 03:29:53 INFO - PID 5670 | Number of tests: 14 03:29:53 INFO - PID 5670 | 03:29:53 INFO - PID 5670 | [#0] ai-astar Cycles:10 Average:107.80 Median:110.00 stddev:4.10 (3.7%) stddev-sans-first:3.24 03:29:53 INFO - PID 5670 | Values: 100.0 108.0 107.0 109.0 110.0 110.0 111.0 101.0 110.0 112.0 03:29:53 INFO - PID 5670 | 03:29:53 INFO - PID 5670 | [#1] audio-beat-detection Cycles:10 Average:142.60 Median:147.50 stddev:26.11 (17.7%) stddev-sans-first:27.56 03:29:53 INFO - PID 5670 | Values: 150.0 117.0 139.0 185.0 119.0 147.0 148.0 119.0 185.0 117.0 03:29:53 INFO - PID 5670 | 03:29:53 INFO - PID 5670 | [#2] audio-dft Cycles:10 Average:164.00 Median:163.00 stddev:2.54 (1.6%) stddev-sans-first:2.67 03:29:53 INFO - PID 5670 | Values: 163.0 162.0 163.0 163.0 162.0 162.0 169.0 168.0 165.0 163.0 03:29:53 INFO - PID 5670 | 03:29:53 INFO - PID 5670 | [#3] audio-fft Cycles:10 Average:96.40 Median:76.50 stddev:39.84 (52.1%) stddev-sans-first:41.49 03:29:53 INFO - PID 5670 | Values: 75.0 77.0 78.0 182.0 88.0 76.0 75.0 76.0 160.0 77.0 03:29:53 INFO - PID 5670 | 03:29:53 INFO - PID 5670 | [#4] audio-oscillator Cycles:10 Average:96.60 Median:81.00 stddev:25.32 (31.3%) stddev-sans-first:26.13 03:29:53 INFO - PID 5670 | Values: 80.0 83.0 140.0 81.0 81.0 80.0 132.0 81.0 81.0 127.0 03:29:53 INFO - PID 5670 | 03:29:53 INFO - PID 5670 | [#5] imaging-gaussian-blur Cycles:10 Average:114.60 Median:114.00 stddev:2.22 (1.9%) stddev-sans-first:2.18 03:29:53 INFO - PID 5670 | Values: 117.0 114.0 114.0 114.0 113.0 114.0 113.0 114.0 113.0 120.0 03:29:53 INFO - PID 5670 | 03:29:53 INFO - PID 5670 | [#6] imaging-darkroom Cycles:10 Average:150.60 Median:151.00 stddev:0.52 (0.3%) stddev-sans-first:0.53 03:29:53 INFO - PID 5670 | Values: 151.0 150.0 150.0 151.0 150.0 151.0 150.0 151.0 151.0 151.0 03:29:53 INFO - PID 5670 | 03:29:53 INFO - PID 5670 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:94.00 stddev:2.10 (2.2%) stddev-sans-first:2.18 03:29:53 INFO - PID 5670 | Values: 94.0 94.0 95.0 94.0 95.0 94.0 94.0 98.0 100.0 94.0 03:29:53 INFO - PID 5670 | 03:29:53 INFO - PID 5670 | [#8] json-parse-financial Cycles:10 Average:54.40 Median:54.50 stddev:0.52 (0.9%) stddev-sans-first:0.50 03:29:53 INFO - PID 5670 | Values: 55.0 54.0 54.0 54.0 54.0 55.0 55.0 55.0 54.0 54.0 03:29:53 INFO - PID 5670 | 03:29:53 INFO - PID 5670 | [#9] json-stringify-tinderbox Cycles:10 Average:55.00 Median:55.00 stddev:1.56 (2.8%) stddev-sans-first:0.73 03:29:53 INFO - PID 5670 | Values: 59.0 54.0 55.0 54.0 54.0 54.0 55.0 55.0 54.0 56.0 03:29:53 INFO - PID 5670 | 03:29:53 INFO - PID 5670 | [#10] stanford-crypto-aes Cycles:10 Average:78.30 Median:78.00 stddev:1.34 (1.7%) stddev-sans-first:1.33 03:29:53 INFO - PID 5670 | Values: 77.0 78.0 78.0 77.0 80.0 81.0 78.0 79.0 77.0 78.0 03:29:53 INFO - PID 5670 | 03:29:53 INFO - PID 5670 | [#11] stanford-crypto-ccm Cycles:10 Average:136.80 Median:136.00 stddev:13.91 (10.2%) stddev-sans-first:12.46 03:29:53 INFO - PID 5670 | Values: 158.0 135.0 134.0 125.0 137.0 139.0 124.0 126.0 126.0 164.0 03:29:53 INFO - PID 5670 | 03:29:53 INFO - PID 5670 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:181.20 Median:180.50 stddev:6.48 (3.6%) stddev-sans-first:6.77 03:29:53 INFO - PID 5670 | Values: 178.0 178.0 178.0 197.0 183.0 179.0 182.0 176.0 186.0 175.0 03:29:53 INFO - PID 5670 | 03:29:53 INFO - PID 5670 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.40 Median:70.00 stddev:1.71 (2.4%) stddev-sans-first:1.74 03:29:53 INFO - PID 5670 | Values: 68.0 70.0 72.0 70.0 70.0 68.0 69.0 68.0 72.0 67.0 03:29:53 INFO - PID 5670 | -------- Summary: end -------- 03:29:53 INFO - PID 5670 | 03:29:53 INFO - PID 5670 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 03:29:53 INFO - TEST-INFO | 5670: exit 0 03:29:54 INFO - TEST-OK | kraken | took 62989ms 03:29:54 INFO - SUITE-END | took 1176s 03:29:54 INFO - Completed test suite (00:19:37) 03:29:54 INFO - javascript benchmark 03:29:54 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8349.58328020114, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3086.984565077175, 3114.112477943785, 3118.0957522318527, 3124.531320301956, 3144.6698096699847, 5899.292084949812, 5936.079907614316, 5964.13520039594, 5989.802039592083, 6114.480269177126, 5837.795677151301, 5945.791897283585, 5946.613470124439, 5958.136070269808, 5975.924333619947, 5519.365272993607, 5536.2249285100115, 5551.528120109796, 5552.333719953591, 5625.5499560035305, 5591.916121258164, 5644.915326270109, 5657.20799088128, 5657.632253903504, 5714.771409143629, 5408.918866216971, 5603.991281569336, 5624.775008999635, 5663.348714897798, 5699.743511541969, 5412.8386104649135, 5531.585131115183, 5544.889102217973, 5611.410801865786, 5623.775048998035, 5518.034343989786, 5554.333479982428, 5567.137093750475, 5630.5495560355075, 5651.378348381675, 5889.734961926723, 5999.400059994009, 6020.909686354708, 6079.118527813443, 6084.26988761347, 6413.583117097421, 6472.838179045514, 6486.610803351814, 6496.350364963466, 6504.739810407578, 6470.708818103197, 6553.14809074822, 6554.377334153248, 6581.440577550866, 6654.534182607219, 5981.671008094597, 6014.51883849291, 6042.909356359658, 6110.541709371815, 6170.784022559234, 6546.18172728409, 6702.0, 6739.427148692416, 6778.423833974168, 6791.932080679228, 6358.1734374531015, 6382.680865956683, 6423.068655044993, 6429.099926010363, 6441.742330306735, 6483.4164925156965, 6525.0, 6562.884309667273, 6590.670466476753, 6604.636744978976, 6323.557350985387, 6326.2724786649205, 6404.71178796946, 6420.935790642127, 6460.450861676716, 6412.845687776152, 6475.579087359307, 6491.285958544557, 6561.934380656227, 6573.276939536647, 5166.0, 5195.0, 5251.765835028765, 5293.179557168645, 5298.125809241432, 4408.779561021936, 4506.3465797459185, 4507.2788353863225, 4507.5267096955, 4600.5629465200755, 5652.886942261214, 5667.971660141673, 5683.431656834284, 5687.431256874363, 5745.798897038583, 6457.741690332334, 6458.773942912069, 6534.575252608565, 6543.083968244449, 6637.6349300788925, 5561.77752889888, 5624.521915637135, 5651.067573850269, 5694.914576281359, 5695.829125126253, 5699.800506982236, 5772.595918285764, 5783.161441590946, 5795.043817770105, 5801.158831969426, 6330.177076979963, 6333.524985626004, 6397.7440902364315, 6435.774747883802, 6435.806925792233, 6407.295197528175, 6509.283978762427, 6510.674466276762, 6620.073189753342, 6624.6025238485845, 6363.649999250086, 6428.903566446601, 6441.838954026187, 6450.193725784277, 6460.741570337133, 6421.454176394872, 6450.064740612679, 6532.5753826001155, 6554.0, 6556.868862622816, 6550.574212676161, 6553.389624378986, 6623.072769812326, 6630.46956243509, 6643.368879956396, 6238.656873871799, 6277.748890044347, 6315.5894866833505, 6341.239051313872, 6349.460295874717, 6251.531135164972, 6381.138546296376, 6401.711922963571, 6412.775552855627, 6423.743050277936, 6244.750209991549, 6252.343503932204, 6300.62196268207, 6306.621602703853, 6370.872582548416, 6276.811695649138, 6303.49572034227, 6356.396142366468, 6362.618242905441, 6371.012493063583, 6207.720652570555, 6234.688265586793, 6254.312025677263, 6261.092141639346, 6265.749370025148], "value": 5948.734271793762, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [770.9383249340053, 822.2681813186264, 843.7426584891607, 845.2181731897992, 1101.5648818716613, 29695.25761855952, 40728.18543629129, 41697.166056678885, 41745.373819392735, 41791.0, 42114.36828447576, 42480.3627945581, 42482.787586062026, 42529.0, 42566.57433425665, 7170.247124051978, 7446.962765186194, 7536.133344665365, 7886.053673559181, 7890.526568405885, 7667.616619169047, 7737.07155141381, 7755.418343624251, 7770.533767973911, 7771.611419429034, 7707.421943354243, 7762.8447431051345, 7775.455718099707, 7783.104942931551, 7792.805179870492, 7728.26581474759, 7728.459007869451, 7729.497582657165, 7777.261160189773, 7782.299593036597, 7698.653560589787, 7724.30481256684, 7734.961325193394, 7762.844743105106, 7785.4939428937505, 38685.0, 38966.22067558633, 39013.21973560541, 39029.80485097556, 39050.80474597637, 3519.577650681909, 3592.3354179476883, 3602.0274525878126, 3613.0, 3613.692836108934, 31272.0, 31286.530702039487, 31429.685703142906, 31442.685573144205, 31456.842715786504, 4837.9516204837855, 4918.5573298403315, 4922.827701030446, 4947.109520286347, 4952.455229924705, 193817.0, 195183.0, 195593.0, 196546.01726991415, 197298.0, 48128.5187148131, 48176.27735583969, 48182.75908620505, 48263.75868120637, 48265.0, 50341.0, 50802.0, 50890.236646450336, 51022.48977510251, 51077.0, 15841.128737919526, 16172.272247748879, 16191.75712364292, 16231.107289098976, 16282.267297971619, 11542.0, 11712.88287117135, 12602.621921342374, 13277.867221327662, 13311.534096306776, 13357.198568085945, 13432.059755817, 13533.932330338483, 13644.522441714493, 13713.520026799015, 5326.0, 5390.407055223922, 5495.725213739297, 5547.889042219133, 5556.138798486241, 983.4836710726926, 987.2842189412762, 990.5047476261869, 1017.862588550551, 1033.6330602635956, 22575.435614109778, 22614.321570352917, 22674.773252267598, 23283.7671623285, 23295.0, 1076.7900259449332, 1086.9945650271698, 1105.8120119579692, 1117.9776404472027, 1120.372591348831, 11829.940850295694, 11999.940000299943, 12140.332281724413, 12183.878161218452, 12217.877821221851, 221430.0, 222474.0, 222931.0, 223016.0, 224060.0, 53775.73112134414, 53940.46059539433, 54109.72945135249, 54214.0, 54652.0, 1458.6499240182493, 1463.604826696786, 1496.835348111707, 1500.6398464368692, 1505.503183949316, 21917.232896848534, 22112.11551537985, 22725.204617838295, 23032.193873215027, 23075.076996919935, 48138.75930620325, 50851.0, 50869.74565127151, 50930.0, 51132.74433627808, 195594.0, 196612.0, 197094.0, 197150.0, 197259.0, 31208.37583248277, 31942.840285798422, 33908.66091339055, 34246.0, 34743.47884781781, 44744.77627611841, 46688.29967550557, 47008.52991470179, 47296.763516182196, 47791.28313075376, 32025.839870800497, 33661.83169084139, 33766.32467350688, 33797.49303760396, 33919.15202119868, 32247.35505289834, 32694.34611307808, 33828.0, 34134.317313654086, 34550.13624659403, 36756.264874701825, 37661.0, 37954.81022594869, 38077.0, 38149.4277585842, 30427.2393190172, 32177.83911080523, 32363.67636323701, 32484.675153248165, 32529.674703252665, 22590.548189036457, 24286.392840179138, 24316.878415608517, 24419.38951526226, 24561.877190613934], "value": 17310.641539380806, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [576.2508738639767, 581.2008488328547, 581.6451964301777, 585.3853453873431, 613.6348872420909, 15995.120268385233, 21582.244621438254, 22661.320160395193, 22667.09331626733, 22680.659790103142, 17063.232154553043, 19179.232830686757, 20911.37265882026, 20927.058282377293, 21048.158073677074, 6049.0, 6215.502759779207, 6276.843078923018, 6330.050492426127, 6331.335209802974, 5637.210790489335, 6162.969185154068, 6166.7533298667995, 6258.374162583728, 6333.334999825021, 6243.594166379194, 6251.624902505841, 6252.718192770471, 6261.27995280544, 6276.246850377961, 6257.217847769029, 6262.655553944532, 6273.12176295319, 6274.811755647338, 6278.529110316745, 5774.5091667208335, 5808.12878068289, 5851.736671849777, 5861.150133230701, 5878.676672782995, 26228.213153605422, 27834.443311133666, 28377.290567735767, 28514.429711405657, 28535.71464285372, 1884.5006073390425, 1923.0673123535214, 1924.6728056230475, 1927.180948097053, 1929.4790406590282, 17656.293748250184, 18128.728069078974, 18165.636687266182, 18175.363862264756, 18326.725099123523, 2246.595612789697, 2265.9433514162115, 2285.748567657556, 2308.1575225042907, 2323.6630688550067, 136367.0, 139834.90247646294, 139861.0, 140170.29914850462, 140304.0, 13786.241756703277, 14515.346809393603, 14638.53614638549, 14655.0, 14743.557693269218, 22634.320970370914, 22676.433089172573, 22700.205492807672, 22816.0, 22858.657120143213, 9801.0, 9822.607095716092, 9932.900670993198, 9987.900120998696, 10136.0877521022, 9050.592723327467, 9123.36136470454, 9152.725418237464, 9204.125608067223, 9319.90680093204, 8848.690295839744, 10863.239573229797, 11110.55557777696, 11341.773164536664, 11862.644120676394, 3573.76770509916, 3864.7487913285545, 3930.606939306104, 4446.866594002185, 4586.4496260448295, 948.3569447896407, 952.2096659772373, 954.1889394015031, 989.5101924547395, 991.7619771254991, 18680.439586812146, 19108.426747197605, 21873.453163671034, 23508.764912351, 23617.527649446914, 1022.4070039377143, 1034.0216906848968, 1071.4374953149659, 1073.0342691577487, 1076.160594736107, 10547.894521054845, 10981.956714112306, 11028.44857757109, 11080.0, 11266.54933802655, 453797.0, 475719.0, 478923.0, 480615.0, 482076.0, 116656.41671791587, 117371.41314293545, 118609.40695296641, 120521.0, 122898.0, 1276.9170003949898, 1277.4570807406815, 1294.5598496511043, 1294.9158304710163, 1303.2310936547483, 16391.180440978143, 20125.295614653416, 20809.0, 20842.68735968992, 20863.582728345045, 55832.0, 56024.0, 56976.0, 57700.42299577119, 58159.4184058154, 63751.6812415935, 65219.0, 65242.0, 65704.0, 65923.67038164778, 12099.81850272229, 12576.685582860502, 12591.370431478206, 14208.857911420753, 14750.188739619423, 22393.552128957002, 22992.310230693107, 23212.3036308911, 23309.0, 23363.415914602272, 18099.81900181034, 18175.363862265287, 18328.0, 18337.266509339475, 18368.724469132707, 16405.343786248894, 16557.960346729116, 16780.74828877592, 17184.054876981885, 17253.913730431268, 18364.255395737382, 18471.35350262788, 18671.15979780886, 18686.06569671484, 18932.337368192046, 14177.007609467239, 14206.07660502064, 14243.145411275356, 14273.857261427253, 14320.713585728436, 18189.909050454662, 18204.99872506972, 18311.633767324845, 18372.54068648241, 18605.720914186026], "value": 11893.933950558416, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1360.1770928588203, 1406.507722297196, 1429.9928500357496, 1432.2838580709645, 1435.1460880775942, 12119.0, 13544.932275338622, 14060.29698515074, 14133.0, 14199.361028753705, 12187.08596855235, 12329.260244385321, 13264.403101860415, 13908.791368129487, 13914.234717090581, 2690.5964105384155, 2767.266674331294, 2769.4461107778425, 2773.1403264987816, 2773.62556054932, 2630.487055024271, 2711.281510399736, 2718.0350975403744, 2728.358835673615, 2731.3581308392513, 2647.761701446869, 2689.0453888869465, 2693.8383696978244, 2693.946121077577, 2695.0567301444535, 2579.20044786116, 2602.58358662614, 2606.4656745367342, 2614.307208589725, 2615.712271650117, 2554.463562651845, 2556.5398228318895, 2560.6799150106235, 2562.5131225067175, 2566.0377358490564, 13461.394237259346, 13537.578554251859, 13538.0, 13570.728585428335, 13581.185128892299, 7113.92886071143, 7330.743423980189, 7345.55926644403, 7363.410927125817, 7367.373773229282, 4613.861584152447, 4852.8301509447, 5043.344365232533, 5059.848204553869, 5064.139096353629, 1858.721191821224, 1866.5333666583354, 1870.0743132149537, 1894.7494653528743, 1907.1322548240516, 21758.564828703496, 21991.120355185933, 22133.778662213495, 22249.66625500619, 22318.776812231834, 6877.552959057645, 7085.92914070863, 7114.608696521637, 7134.92865071353, 7157.856842863113, 15599.844001560066, 15734.68530629381, 15768.132752698482, 15802.446914357943, 15806.288717007763, 7410.555366678017, 7645.847083058307, 7652.65563049653, 7663.655135518915, 7676.80807979805, 5796.478316951495, 5830.5044071254415, 6070.271567411851, 6156.384361563808, 6158.107074474176, 5049.974750126225, 5162.6128040397125, 5268.28878101459, 5291.1798671206025, 5307.946920530822, 1489.7244009858211, 1519.1492764052166, 1525.7711343298595, 1539.1380826737063, 1539.7151526967548, 862.784303924019, 868.5830801215452, 869.7825543614097, 895.9462432254086, 904.7376260884402, 7083.362497375261, 7112.03987461686, 7125.180604230476, 7202.099737532809, 7238.420926325882, 659.4691273524859, 671.177807186193, 689.9344562266576, 690.7547820523641, 692.62944324786, 4123.092919557693, 4537.6143027843, 4913.361263035782, 5019.437970665887, 5081.364829396325, 17865.7320140198, 19510.804891951182, 19515.316963906196, 19536.902315488616, 19546.511337216398, 18785.81214187868, 19005.80994190068, 19109.80890191108, 19184.90407547953, 19342.226310947404, 9681.789776277965, 10271.794564108675, 10289.125424338865, 10293.74265643365, 10356.533955972, 7365.52124111931, 7473.51422157558, 7610.8097297568, 7665.8466830661955, 7720.073591169095, 16058.8394116062, 16404.835951640332, 16760.32958681688, 16797.91601041987, 16892.66214675724, 16441.83558164403, 16542.33830646809, 16836.326546938475, 16875.240614172148, 17179.14104294755, 10329.276950613685, 10497.2127090467, 10497.580096796348, 10498.212634052325, 10512.684619461428, 13084.214947103204, 13576.93211533936, 13589.660258493617, 13594.048416610742, 13600.727985440433, 10519.211059170746, 10990.780184396428, 11062.22564420483, 11081.667549973514, 11407.828882566602, 10064.079530482646, 10621.415822129857, 10743.355398676105, 10782.460876955964, 10962.835557466486, 9208.815823683623, 9400.670976515788, 9406.341556091007, 9476.052394760469, 9525.904740952501, 6825.2833452486775, 7181.820454488679, 7292.489525733148, 7319.121705395387, 7330.890036649348, 7029.5430796998035, 7075.646217688992, 7080.520829172956, 7113.3953613943395, 7191.993120962965], "value": 6206.425061190611, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [483.2871514516087, 496.1837776857069, 511.5242824173522, 520.0742678033101, 522.4879617974385, 6082.695865206739, 6088.208532890723, 6124.938750612492, 6215.59598626089, 6273.3412991635905, 5823.2138661280715, 5957.7021148942595, 5976.223090998175, 5987.7604895804225, 6076.908846367308, 4821.156297647915, 4832.661713680044, 4856.854294371157, 4870.220764677652, 4874.295535393109, 4685.672002959795, 4767.809287628508, 4809.254565542346, 4812.542808433193, 4880.9755951220195, 4770.332153498513, 4847.806087756486, 4850.248211527219, 4861.368022157115, 4887.266909963516, 4837.419509658828, 4901.65688401812, 4906.558409743105, 4926.704397736147, 4935.629827762932, 4380.474343078851, 4391.377113881061, 4394.8901277468, 4408.977955110236, 4431.246688063037, 6006.699665016732, 6014.368491308437, 6036.852997930423, 6040.516758659341, 6044.576879618428, 5569.164625306196, 5582.972085139589, 5635.211070450099, 5636.859078523029, 5641.125625528009, 6431.131797207364, 6436.90800489838, 6461.870762584769, 6469.805905822833, 6474.482041436674, 4692.41344831896, 4757.715416837469, 4820.228763397839, 4835.0, 4846.5880400166025, 6696.2968888267005, 6729.293424190488, 6809.319068093151, 6815.7614483493335, 6863.176418829772, 4840.854774356775, 4857.854264372075, 4872.14737420957, 4898.657094003457, 4919.434265059493, 5007.24891266313, 5014.423341315795, 5053.67151135175, 5059.610061258892, 5060.746962651852, 5546.4453554644215, 5623.184638227516, 5669.31968163823, 5682.403347648437, 5729.8567535811935, 6174.351693072253, 6312.936870631327, 6380.3619638035825, 6407.7436902524305, 6495.382938620824, 1626.682796854602, 1678.152532970842, 1682.8990260584403, 1711.0674682298177, 1742.5469377961567, 1177.7997740383985, 1188.9643310700692, 1198.4487135917575, 1206.7646808872362, 1218.79889818179, 5597.244372009726, 5641.9533451935495, 5687.857803554862, 5700.23046888673, 5756.539476841843, 6406.391392817675, 6464.353564643498, 6559.180102487189, 6597.505187110986, 6642.568233064835, 5660.15097735343, 5674.77300907959, 5674.801381951612, 5711.029694755386, 5722.484976352065, 3463.4631632097066, 3493.6681015303507, 3502.824858757052, 3546.361654902142, 3551.751377403609, 6403.359664033559, 6403.97536394184, 6442.35576442352, 6458.5479016469335, 6462.256840463313, 6724.798256052326, 6734.521543173734, 6751.25736169021, 6807.625580593115, 6836.623985680835, 6342.873142537216, 6346.428821406095, 6350.65071421067, 6361.363863613694, 6381.3937675920715, 6403.0715546246465, 6504.219493660791, 6603.273639899511, 6637.0420725885015, 6641.269460359454, 6528.771492997912, 6546.279909209888, 6564.80305590833, 6567.31043240472, 6612.570182938093, 6345.270293916259, 6358.745650173942, 6422.839429014312, 6455.903161452488, 6477.352264773674, 4907.975460122677, 4911.901761964812, 4949.282354058713, 4954.157793175097, 4979.377577802775, 6415.615063096229, 6588.439982601532, 6610.603363798187, 6630.149035914603, 6661.700223489857, 6279.780207692709, 6351.078503888263, 6424.0, 6445.806625801233, 6452.548321617442, 6279.780207692892, 6332.556721029484, 6398.648074355955, 6476.676166191577, 6490.3185165558825, 6245.96877015612, 6321.462675672619, 6338.809835704937, 6341.55609107358, 6358.332375100548, 6170.259568851767, 6286.52851036165, 6291.0, 6376.266729326001, 6396.520260980352, 6201.410865967726, 6238.968805155945, 6245.375462453719, 6251.906221406592, 6268.780592679234], "value": 4957.966702242191, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [898.416029580772, 911.7811725185954, 921.433318509117, 925.4678559828101, 935.4574346878811, 17600.383986560457, 18543.629127417444, 18581.72127418088, 18773.62452750944, 21408.46478838026, 20898.582028359422, 21644.134234630597, 21782.673259901116, 21791.0, 21967.890160549174, 977.9217662586976, 995.1889210293588, 1004.372267332917, 1004.5780772075709, 1006.1598565198068, 962.3263715399214, 1053.8208504554243, 1058.0477570186854, 1059.7350662334416, 1061.1828891753346, 1108.362691452414, 1111.1000089927145, 1113.838493418454, 1114.0753174864883, 1114.5486078138326, 1108.7505311304933, 1109.4563663804677, 1110.8666959964776, 1111.794318051159, 1114.1977776001265, 804.6137853830194, 808.6684459371688, 813.5078277642001, 816.2286639126029, 823.7487566292278, 17228.827711722846, 17616.91191544034, 17624.325689059646, 17663.205155767893, 20203.696944545845, 20127.79872201274, 20319.18723251068, 20951.68572471414, 20985.685214721638, 21229.044692988853, 15724.921375393164, 15817.920910395374, 15841.049537027815, 15872.92063539675, 16418.932769370072, 3555.5022296878456, 3578.320119177348, 3580.051286409104, 3582.3193593217206, 3586.4799604057525, 118110.0, 120113.0, 123501.0, 124757.37621311926, 127739.0, 15392.846071539365, 15827.52517424479, 16316.836831631768, 16321.714959905623, 16330.836691632932, 29524.557131643043, 29799.851000744857, 29881.850590746908, 30196.24509387239, 30368.0, 8423.831523369621, 8461.788455288544, 8505.61724722389, 8511.404201705822, 8541.231289184003, 4012.0972781124597, 4087.202995415865, 4127.0, 4130.690198235085, 4136.689748268892, 5020.723860187724, 5032.6980381177245, 5085.7202853842655, 5112.284280200774, 5169.198774190007, 940.7083804020639, 951.1534734086669, 953.880764904387, 954.9972528844825, 956.0391806234828, 670.4301343857682, 673.1417442760519, 683.1221879884325, 712.7113519024804, 717.6304203335286, 11380.544778208945, 11883.742089003063, 11890.464929078213, 11976.52093916251, 12518.561850335194, 623.7006237006262, 643.9227292724903, 662.3773652766384, 666.8832954232989, 678.5080816408065, 5089.592832573459, 5102.902875881629, 5675.5459563234845, 5918.763249470059, 6079.756809727562, 94731.52634236784, 98270.0, 98446.50776746214, 99017.0, 101743.0, 86162.0, 86934.56532717295, 87809.0, 90452.0, 91640.0, 74153.25846741571, 75920.0, 75965.6201718999, 76043.23956760472, 78720.0, 11848.466818992994, 12375.071869609996, 12553.121281510206, 12556.0, 12923.28921909304, 32688.673113269513, 34103.218516209556, 35132.94601161969, 35350.64649353473, 38017.429738553394, 62596.374036259054, 63553.0, 65202.0, 66076.0, 67573.66213168902, 18961.336353227573, 19112.0, 19136.808631913504, 19195.232190712217, 19314.13086411143, 20538.589228215053, 21179.68230476575, 21229.787702123398, 21440.0, 21814.345569632937, 16871.83128168752, 17499.38752143669, 17685.292588296325, 18076.0, 18148.909255453636, 16430.424935127212, 16510.917445412695, 16639.50081497557, 16689.332426702797, 16723.74914376261, 18453.53866153303, 18510.629787404447, 18816.435506934813, 18889.90555047216, 19341.226350945806, 13064.0, 13323.13399629021, 14279.71440571162, 14489.855101448851, 14679.55961321162, 14116.223607701675, 14402.20787856678, 14492.782608261095, 14712.190829504052, 14843.851561484678], "value": 8989.841401944701, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1542.9, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 108.0, 107.0, 109.0, 110.0, 110.0, 111.0, 101.0, 110.0, 112.0], "value": 107.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 117.0, 139.0, 185.0, 119.0, 147.0, 148.0, 119.0, 185.0, 117.0], "value": 142.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 162.0, 163.0, 163.0, 162.0, 162.0, 169.0, 168.0, 165.0, 163.0], "value": 164.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 77.0, 78.0, 182.0, 88.0, 76.0, 75.0, 76.0, 160.0, 77.0], "value": 96.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 83.0, 140.0, 81.0, 81.0, 80.0, 132.0, 81.0, 81.0, 127.0], "value": 96.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 114.0, 114.0, 114.0, 113.0, 114.0, 113.0, 114.0, 113.0, 120.0], "value": 114.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 150.0, 150.0, 151.0, 150.0, 151.0, 150.0, 151.0, 151.0, 151.0], "value": 150.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 95.0, 94.0, 95.0, 94.0, 94.0, 98.0, 100.0, 94.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 54.0, 54.0, 54.0, 54.0, 55.0, 55.0, 55.0, 54.0, 54.0], "value": 54.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 54.0, 55.0, 54.0, 54.0, 54.0, 55.0, 55.0, 54.0, 56.0], "value": 55.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 78.0, 78.0, 77.0, 80.0, 81.0, 78.0, 79.0, 77.0, 78.0], "value": 78.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 135.0, 134.0, 125.0, 137.0, 139.0, 124.0, 126.0, 126.0, 164.0], "value": 136.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [178.0, 178.0, 178.0, 197.0, 183.0, 179.0, 182.0, 176.0, 186.0, 175.0], "value": 181.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 70.0, 72.0, 70.0, 70.0, 68.0, 69.0, 68.0, 72.0, 67.0], "value": 69.4, "unit": "score"}]}]} 03:29:54 INFO - Return code: 0 03:29:54 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:29:54 INFO - # TBPL SUCCESS # 03:29:54 INFO - Running post-action listener: _package_coverage_data 03:29:54 INFO - Running post-action listener: _resource_record_post_action 03:29:54 INFO - [mozharness: 2017-07-22 10:29:54.504755Z] Finished run-tests step (success) 03:29:54 INFO - Running post-run listener: _resource_record_post_run 03:29:54 INFO - Total resource usage - Wall time: 1195s; CPU: 13.0%; Read bytes: 20480; Write bytes: 449241088; Read time: 308; Write time: 506176 03:29:54 INFO - TinderboxPrint: CPU usage
13.2% 03:29:54 INFO - TinderboxPrint: I/O read bytes / time
20,480 / 308 03:29:54 INFO - TinderboxPrint: I/O write bytes / time
449,241,088 / 506,176 03:29:54 INFO - TinderboxPrint: CPU idle
8,271.4 (86.8%) 03:29:54 INFO - TinderboxPrint: CPU user
1,202.7 (12.6%) 03:29:54 INFO - TinderboxPrint: Swap in / out
0 / 0 03:29:54 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 4096; Write bytes: 119734272; Read time: 68; Write time: 138696 03:29:54 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 03:29:54 INFO - run-tests - Wall time: 1178s; CPU: 13.0%; Read bytes: 12288; Write bytes: 329506816; Read time: 220; Write time: 367480 03:29:55 INFO - Running post-run listener: _upload_blobber_files 03:29:55 INFO - Blob upload gear active. 03:29:55 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:29:55 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:29:55 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:29:55 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:29:55 INFO - (blobuploader) - INFO - Open directory for files ... 03:29:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:29:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:29:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:29:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:29:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:29:56 INFO - (blobuploader) - INFO - Done attempting. 03:29:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:29:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:29:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:29:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:29:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:29:57 INFO - (blobuploader) - INFO - Done attempting. 03:29:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:29:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:29:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:30:00 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:30:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:30:00 INFO - (blobuploader) - INFO - Done attempting. 03:30:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 03:30:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:30:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:30:01 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 03:30:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:30:01 INFO - (blobuploader) - INFO - Done attempting. 03:30:01 INFO - (blobuploader) - INFO - Iteration through files over. 03:30:01 INFO - Return code: 0 03:30:01 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:30:01 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:30:01 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/316552f50f127dcc7658474925ff0948451f02bfe9427f6a3a1406bef7e95be991f0834828e15010fd101d8d4be1a661f3048674293f6e9401beea5c019215a8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/01f4a8a064395c32cdce0fb90e76ab20f79b39584d61beb026d70056e7981077790c973ee27f238c15d5b550ce9cec7e46900f7dd5242ef05b3c37720fc0a110", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b58e40f0bb0dd4483be944fd6f08fce70e954534488db4b5d535ba994584ef4f985ebdeca294fd6b64afd79561e3a9a8c951fa5b153314f16d68b6ffc6d1b1fd", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/975b95711cc56989c1afd7c06117330803af13ba6d6296957cc15eb0104c8e8a770e9507ba402ca66aa5f30546ff7bac09cd5595f78894ff97a605e0bc5978e1"} 03:30:01 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:30:01 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:30:01 INFO - Contents: 03:30:01 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/316552f50f127dcc7658474925ff0948451f02bfe9427f6a3a1406bef7e95be991f0834828e15010fd101d8d4be1a661f3048674293f6e9401beea5c019215a8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/01f4a8a064395c32cdce0fb90e76ab20f79b39584d61beb026d70056e7981077790c973ee27f238c15d5b550ce9cec7e46900f7dd5242ef05b3c37720fc0a110", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b58e40f0bb0dd4483be944fd6f08fce70e954534488db4b5d535ba994584ef4f985ebdeca294fd6b64afd79561e3a9a8c951fa5b153314f16d68b6ffc6d1b1fd", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/975b95711cc56989c1afd7c06117330803af13ba6d6296957cc15eb0104c8e8a770e9507ba402ca66aa5f30546ff7bac09cd5595f78894ff97a605e0bc5978e1"} 03:30:01 INFO - Running post-run listener: copy_logs_to_upload_dir 03:30:01 INFO - Copying logs to upload dir... 03:30:01 INFO - mkdir: /builds/slave/test/build/upload/logs 03:30:01 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1258.642239 ========= master_lag: 1.76 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2017-07-22 03:30:02.199276) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-07-22 03:30:02.202445) ========= 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=fa44defc139c4ba8574fe040000001db-1500700471.24775-715283986 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/316552f50f127dcc7658474925ff0948451f02bfe9427f6a3a1406bef7e95be991f0834828e15010fd101d8d4be1a661f3048674293f6e9401beea5c019215a8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/01f4a8a064395c32cdce0fb90e76ab20f79b39584d61beb026d70056e7981077790c973ee27f238c15d5b550ce9cec7e46900f7dd5242ef05b3c37720fc0a110", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b58e40f0bb0dd4483be944fd6f08fce70e954534488db4b5d535ba994584ef4f985ebdeca294fd6b64afd79561e3a9a8c951fa5b153314f16d68b6ffc6d1b1fd", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/975b95711cc56989c1afd7c06117330803af13ba6d6296957cc15eb0104c8e8a770e9507ba402ca66aa5f30546ff7bac09cd5595f78894ff97a605e0bc5978e1"} build_url:https://queue.taskcluster.net/v1/task/FpuMD3hSStKv4jAqluX4GQ/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011269 build_url: 'https://queue.taskcluster.net/v1/task/FpuMD3hSStKv4jAqluX4GQ/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/316552f50f127dcc7658474925ff0948451f02bfe9427f6a3a1406bef7e95be991f0834828e15010fd101d8d4be1a661f3048674293f6e9401beea5c019215a8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/01f4a8a064395c32cdce0fb90e76ab20f79b39584d61beb026d70056e7981077790c973ee27f238c15d5b550ce9cec7e46900f7dd5242ef05b3c37720fc0a110", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b58e40f0bb0dd4483be944fd6f08fce70e954534488db4b5d535ba994584ef4f985ebdeca294fd6b64afd79561e3a9a8c951fa5b153314f16d68b6ffc6d1b1fd", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/975b95711cc56989c1afd7c06117330803af13ba6d6296957cc15eb0104c8e8a770e9507ba402ca66aa5f30546ff7bac09cd5595f78894ff97a605e0bc5978e1"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-07-22 03:30:02.245595) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-07-22 03:30:02.246016) ========= 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=fa44defc139c4ba8574fe040000001db-1500700471.24775-715283986 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004516 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-07-22 03:30:02.302159) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-07-22 03:30:02.302500) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-07-22 03:30:02.302854) ========= ========= Total master_lag: 1.93 =========