builder: mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s slave: talos-linux64-ix-015 starttime: 1503014746.68 results: success (0) revision: a6a1f5c1d971dbee67ba6eec7ead7902351ddca2 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-08-17 17:05:46.680731) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-08-17 17:05:46.681272) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-17 17:05:46.681628) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-17 17:05:46.697441) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-17 17:05:46.697778) ========= 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=20e666a3d4cfbb71505a330e000001b4-1503014745.989892-372896200 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-08-17 17:05:46-- 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% 33.6M=0s 2017-08-17 17:05:47 (33.6 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.155153 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-17 17:05:46.871337) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-17 17:05:46.871658) ========= 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=20e666a3d4cfbb71505a330e000001b4-1503014745.989892-372896200 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.023282 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-17 17:05:46.920955) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-17 17:05:46.921305) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev a6a1f5c1d971dbee67ba6eec7ead7902351ddca2 --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 a6a1f5c1d971dbee67ba6eec7ead7902351ddca2 --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=20e666a3d4cfbb71505a330e000001b4-1503014745.989892-372896200 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-08-17 17:05:47,145 truncating revision to first 12 chars 2017-08-17 17:05:47,145 Setting DEBUG logging. 2017-08-17 17:05:47,145 attempt 1/10 2017-08-17 17:05:47,145 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/a6a1f5c1d971?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-08-17 17:05:47,599 unpacking tar archive at: mozilla-central-a6a1f5c1d971/testing/mozharness/ program finished with exit code 0 elapsedTime=0.785051 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-17 17:05:47.726987) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-17 17:05:47.727325) ========= script_repo_revision: a6a1f5c1d971dbee67ba6eec7ead7902351ddca2 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-17 17:05:47.727712) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-17 17:05:47.728014) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-17 17:05:47.747713) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2017-08-17 17:05:47.748086) ========= /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=20e666a3d4cfbb71505a330e000001b4-1503014745.989892-372896200 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:05:48 INFO - MultiFileLogger online at 20170817 17:05:48 in /builds/slave/test 17:05:48 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 17:05:48 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:05:48 INFO - {'append_to_log': False, 17:05:48 INFO - 'base_work_dir': '/builds/slave/test', 17:05:48 INFO - 'blob_upload_branch': 'Firefox', 17:05:48 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:05:48 INFO - 'branch': 'Firefox', 17:05:48 INFO - 'buildbot_json_path': 'buildprops.json', 17:05:48 INFO - 'code_coverage': False, 17:05:48 INFO - 'config_files': ('talos/linux_config.py',), 17:05:48 INFO - 'default_actions': ('clobber', 17:05:48 INFO - 'read-buildbot-config', 17:05:48 INFO - 'download-and-extract', 17:05:48 INFO - 'populate-webroot', 17:05:48 INFO - 'create-virtualenv', 17:05:48 INFO - 'install', 17:05:48 INFO - 'setup-mitmproxy', 17:05:48 INFO - 'run-tests'), 17:05:48 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:05:48 INFO - 'disable_ccov_upload': False, 17:05:48 INFO - 'download_minidump_stackwalk': True, 17:05:48 INFO - 'download_symbols': 'ondemand', 17:05:48 INFO - 'enable_stylo': False, 17:05:48 INFO - 'enable_webrender': False, 17:05:48 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:05:48 INFO - 'tooltool.py': '/tools/tooltool.py', 17:05:48 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:05:48 INFO - '/tools/misc-python/virtualenv.py')}, 17:05:48 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:05:48 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:05:48 INFO - 'gecko_profile': False, 17:05:48 INFO - 'gecko_profile_interval': 0, 17:05:48 INFO - 'installer_path': 'installer.exe', 17:05:48 INFO - 'log_level': 'info', 17:05:48 INFO - 'log_name': 'talos', 17:05:48 INFO - 'log_to_console': True, 17:05:48 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:05:48 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:05:48 INFO - 'opt_config_files': (), 17:05:48 INFO - 'pip_index': False, 17:05:48 INFO - 'suite': 'dromaeojs-e10s', 17:05:48 INFO - 'system_bits': '32', 17:05:48 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:05:48 INFO - 'title': 'talos-linux64-ix-015', 17:05:48 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:05:48 INFO - 'use_talos_json': True, 17:05:48 INFO - 'verify': 'False', 17:05:48 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:05:48 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:05:48 INFO - 'work_dir': 'build'} 17:05:48 INFO - [mozharness: 2017-08-18 00:05:48.110106Z] Running clobber step. 17:05:48 INFO - Running pre-action listener: _resource_record_pre_action 17:05:48 INFO - Running main action method: clobber 17:05:48 INFO - rmtree: /builds/slave/test/build 17:05:48 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:05:49 INFO - Running post-action listener: _resource_record_post_action 17:05:49 INFO - [mozharness: 2017-08-18 00:05:49.240866Z] Finished clobber step (success) 17:05:49 INFO - [mozharness: 2017-08-18 00:05:49.240964Z] Running read-buildbot-config step. 17:05:49 INFO - Running pre-action listener: _resource_record_pre_action 17:05:49 INFO - Running main action method: read_buildbot_config 17:05:49 INFO - Using buildbot properties: 17:05:49 INFO - { 17:05:49 INFO - "project": "", 17:05:49 INFO - "product": "firefox", 17:05:49 INFO - "who": "kwierso@gmail.com", 17:05:49 INFO - "installer_path": "public/build/target.tar.bz2", 17:05:49 INFO - "builddir": "mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s", 17:05:49 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 17:05:49 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo-sequential mozilla-central talos dromaeojs-e10s", 17:05:49 INFO - "stage_platform": "linux64-stylosequential", 17:05:49 INFO - "basedir": "/builds/slave/test", 17:05:49 INFO - "buildnumber": 156, 17:05:49 INFO - "platform": "ubuntu64_hw_styloseq", 17:05:49 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 17:05:49 INFO - "slavebuilddir": "test", 17:05:49 INFO - "taskId": "JtyvaZ99Ql6UslezGF8cmw", 17:05:49 INFO - "branch": "mozilla-central", 17:05:49 INFO - "script_repo_revision": "production", 17:05:49 INFO - "revision": "a6a1f5c1d971dbee67ba6eec7ead7902351ddca2", 17:05:49 INFO - "slavename": "talos-linux64-ix-015", 17:05:49 INFO - "repo_path": "mozilla-central" 17:05:49 INFO - } 17:05:49 INFO - Finding installer, test and symbols from parent task. 17:05:49 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JtyvaZ99Ql6UslezGF8cmw'}, attempt #1 17:05:49 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JtyvaZ99Ql6UslezGF8cmw'}, attempt #1 17:05:50 INFO - Task dependencies: b0RIcHGxQVmCDF_P3NNDKg 17:05:50 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/b0RIcHGxQVmCDF_P3NNDKg'}, attempt #1 17:05:50 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/b0RIcHGxQVmCDF_P3NNDKg/artifacts/public/build/target.tar.bz2 17:05:50 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/b0RIcHGxQVmCDF_P3NNDKg/artifacts/public/build/target.test_packages.json 17:05:50 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/b0RIcHGxQVmCDF_P3NNDKg/artifacts/public/build/target.crashreporter-symbols.zip 17:05:50 INFO - Running post-action listener: _resource_record_post_action 17:05:50 INFO - [mozharness: 2017-08-18 00:05:50.695244Z] Finished read-buildbot-config step (success) 17:05:50 INFO - [mozharness: 2017-08-18 00:05:50.695462Z] Running download-and-extract step. 17:05:50 INFO - Running pre-action listener: _resource_record_pre_action 17:05:50 INFO - Running main action method: download_and_extract 17:05:50 INFO - mkdir: /builds/slave/test/build/tests 17:05:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:05:50 INFO - trying https://queue.taskcluster.net/v1/task/b0RIcHGxQVmCDF_P3NNDKg/artifacts/public/build/target.test_packages.json 17:05:50 INFO - Downloading https://queue.taskcluster.net/v1/task/b0RIcHGxQVmCDF_P3NNDKg/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 17:05:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/b0RIcHGxQVmCDF_P3NNDKg/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 17:05:51 INFO - Downloaded 989 bytes. 17:05:51 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 17:05:51 INFO - Using the following test package requirements: 17:05:51 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 17:05:51 INFO - u'common': [u'target.common.tests.zip'], 17:05:51 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 17:05:51 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 17:05:51 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 17:05:51 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 17:05:51 INFO - u'mozbase': [u'target.common.tests.zip'], 17:05:51 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 17:05:51 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 17:05:51 INFO - u'web-platform': [u'target.common.tests.zip', 17:05:51 INFO - u'target.web-platform.tests.tar.gz'], 17:05:51 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 17:05:51 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 17:05:51 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/b0RIcHGxQVmCDF_P3NNDKg/artifacts/public/build/target.common.tests.zip 17:05:51 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/b0RIcHGxQVmCDF_P3NNDKg/artifacts/public/build/target.common.tests.zip'}, attempt #1 17:05:51 INFO - Fetch https://queue.taskcluster.net/v1/task/b0RIcHGxQVmCDF_P3NNDKg/artifacts/public/build/target.common.tests.zip into memory 17:05:52 INFO - Content-Length response header: 54002001 17:05:52 INFO - Bytes received: 54002001 17:06:03 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 17:06:03 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/b0RIcHGxQVmCDF_P3NNDKg/artifacts/public/build/target.common.tests.zip 17:06:03 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/b0RIcHGxQVmCDF_P3NNDKg/artifacts/public/build/target.common.tests.zip'}, attempt #1 17:06:03 INFO - Fetch https://queue.taskcluster.net/v1/task/b0RIcHGxQVmCDF_P3NNDKg/artifacts/public/build/target.common.tests.zip into memory 17:06:04 INFO - Content-Length response header: 54002001 17:06:04 INFO - Bytes received: 54002001 17:06:16 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/b0RIcHGxQVmCDF_P3NNDKg/artifacts/public/build/target.talos.tests.zip 17:06:16 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/b0RIcHGxQVmCDF_P3NNDKg/artifacts/public/build/target.talos.tests.zip'}, attempt #1 17:06:16 INFO - Fetch https://queue.taskcluster.net/v1/task/b0RIcHGxQVmCDF_P3NNDKg/artifacts/public/build/target.talos.tests.zip into memory 17:06:16 INFO - Content-Length response header: 14496161 17:06:16 INFO - Bytes received: 14496161 17:06:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:06:17 INFO - trying https://queue.taskcluster.net/v1/task/b0RIcHGxQVmCDF_P3NNDKg/artifacts/public/build/target.tar.bz2 17:06:17 INFO - Downloading https://queue.taskcluster.net/v1/task/b0RIcHGxQVmCDF_P3NNDKg/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 17:06:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/b0RIcHGxQVmCDF_P3NNDKg/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 17:06:18 INFO - Downloaded 62316180 bytes. 17:06:18 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/b0RIcHGxQVmCDF_P3NNDKg/artifacts/public/build/target.tar.bz2 17:06:18 INFO - mkdir: /builds/slave/test/properties 17:06:18 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:06:18 INFO - Writing to file /builds/slave/test/properties/build_url 17:06:18 INFO - Contents: 17:06:18 INFO - build_url:https://queue.taskcluster.net/v1/task/b0RIcHGxQVmCDF_P3NNDKg/artifacts/public/build/target.tar.bz2 17:06:18 INFO - Running post-action listener: _resource_record_post_action 17:06:18 INFO - Running post-action listener: find_tests_for_verification 17:06:18 INFO - Running post-action listener: set_extra_try_arguments 17:06:18 INFO - [mozharness: 2017-08-18 00:06:18.282824Z] Finished download-and-extract step (success) 17:06:18 INFO - [mozharness: 2017-08-18 00:06:18.282966Z] Running populate-webroot step. 17:06:18 INFO - Running pre-action listener: _resource_record_pre_action 17:06:18 INFO - Running main action method: populate_webroot 17:06:18 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:06:18 INFO - 'chromez-stylo-e10s': {'talos_options': ['--stylo'], 17:06:18 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:06:18 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:06:18 INFO - 'dromaeojs-stylo-e10s': {'talos_options': ['--stylo'], 17:06:18 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:06:18 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 17:06:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:06:18 INFO - 'g1-stylo-e10s': {'pagesets_name': 'tp5n.zip', 17:06:18 INFO - 'talos_options': ['--stylo'], 17:06:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:06:18 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 17:06:18 INFO - 'tests': ['damp', 'tps']}, 17:06:18 INFO - 'g2-stylo-e10s': {'pagesets_name': 'tp5n.zip', 17:06:18 INFO - 'talos_options': ['--stylo'], 17:06:18 INFO - 'tests': ['damp', 'tps']}, 17:06:18 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:06:18 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 17:06:18 INFO - 'g4-stylo-e10s': {'talos_options': ['--stylo'], 17:06:18 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 17:06:18 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 17:06:18 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 17:06:18 INFO - 'g5-stylo-e10s': {'pagesets_name': 'tp5n.zip', 17:06:18 INFO - 'talos_options': ['--stylo'], 17:06:18 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 17:06:18 INFO - 'other-e10s': {'tests': ['a11yr', 17:06:18 INFO - 'ts_paint', 17:06:18 INFO - 'tpaint', 17:06:18 INFO - 'sessionrestore', 17:06:18 INFO - 'sessionrestore_many_windows', 17:06:18 INFO - 'sessionrestore_no_auto_restore', 17:06:18 INFO - 'tabpaint']}, 17:06:18 INFO - 'other-stylo-e10s': {'talos_options': ['--stylo'], 17:06:18 INFO - 'tests': ['a11yr', 17:06:18 INFO - 'ts_paint', 17:06:18 INFO - 'tpaint', 17:06:18 INFO - 'sessionrestore', 17:06:18 INFO - 'sessionrestore_many_windows', 17:06:18 INFO - 'sessionrestore_no_auto_restore', 17:06:18 INFO - 'tabpaint']}, 17:06:18 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 17:06:18 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 17:06:18 INFO - 'perf-reftest-singletons-stylo-e10s': {'talos_options': ['--stylo'], 17:06:18 INFO - 'tests': ['bloom_basic_singleton']}, 17:06:18 INFO - 'perf-reftest-stylo-e10s': {'talos_options': ['--stylo'], 17:06:18 INFO - 'tests': ['bloom_basic']}, 17:06:18 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:06:18 INFO - 'tsvgr_opacity', 17:06:18 INFO - 'tart', 17:06:18 INFO - 'tscrollx', 17:06:18 INFO - 'tsvg_static']}, 17:06:18 INFO - 'svgr-stylo-e10s': {'talos_options': ['--stylo'], 17:06:18 INFO - 'tests': ['tsvgx', 17:06:18 INFO - 'tsvgr_opacity', 17:06:18 INFO - 'tart', 17:06:18 INFO - 'tscrollx', 17:06:18 INFO - 'tsvg_static']}, 17:06:18 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 17:06:18 INFO - 'tp5o-stylo-e10s': {'pagesets_name': 'tp5n.zip', 17:06:18 INFO - 'talos_options': ['--stylo'], 17:06:18 INFO - 'tests': ['tp5o']}, 17:06:18 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 17:06:18 INFO - 'talos_options': ['--mitmproxy', 17:06:18 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 17:06:18 INFO - '--firstNonBlankPaint'], 17:06:18 INFO - 'tests': ['tp6_google', 17:06:18 INFO - 'tp6_youtube', 17:06:18 INFO - 'tp6_amazon', 17:06:18 INFO - 'tp6_facebook']}, 17:06:18 INFO - 'tp6-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 17:06:18 INFO - 'talos_options': ['--stylo', 17:06:18 INFO - '--mitmproxy', 17:06:18 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 17:06:18 INFO - '--firstNonBlankPaint'], 17:06:18 INFO - 'tests': ['tp6_google', 17:06:18 INFO - 'tp6_youtube', 17:06:18 INFO - 'tp6_amazon', 17:06:18 INFO - 'tp6_facebook']}, 17:06:18 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 17:06:18 INFO - 'talos_options': ['--stylo', 17:06:18 INFO - '--stylo-threads=1', 17:06:18 INFO - '--mitmproxy', 17:06:18 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 17:06:18 INFO - '--firstNonBlankPaint'], 17:06:18 INFO - 'tests': ['tp6_google', 17:06:18 INFO - 'tp6_youtube', 17:06:18 INFO - 'tp6_amazon', 17:06:18 INFO - 'tp6_facebook']}, 17:06:18 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 17:06:18 INFO - 'talos_options': ['--xperf_path', 17:06:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:06:18 INFO - 'tests': ['tp5n']}, 17:06:18 INFO - 'xperf-stylo-e10s': {'pagesets_name': 'tp5n.zip', 17:06:18 INFO - 'talos_options': ['--stylo', 17:06:18 INFO - '--xperf_path', 17:06:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:06:18 INFO - 'tests': ['tp5n']}}} 17:06:18 INFO - Running post-action listener: _resource_record_post_action 17:06:18 INFO - [mozharness: 2017-08-18 00:06:18.297971Z] Finished populate-webroot step (success) 17:06:18 INFO - [mozharness: 2017-08-18 00:06:18.298059Z] Running create-virtualenv step. 17:06:18 INFO - Running pre-action listener: _resource_record_pre_action 17:06:18 INFO - Running main action method: create_virtualenv 17:06:18 INFO - Creating virtualenv /builds/slave/test/build/venv 17:06:18 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 17:06:18 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:06:18 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 17:06:18 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:06:18 INFO - Using real prefix '/usr' 17:06:18 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:06:18 INFO - Installing distribute.............................................................................................................................................................................................done. 17:06:20 INFO - Installing pip.................done. 17:06:20 INFO - Return code: 0 17:06:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 17:06:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 17:06:21 INFO - Reading from file tmpfile_stdout 17:06:21 INFO - Output received: 17:06:21 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) 17:06:21 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:06:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:06:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:06:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:06:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:06:21 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 0x17a81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18aca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a4fc30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a4ccc0>, '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 0x1a4dcd0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a4e160>, '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': '20e666a3d4cfbb71505a330e000001b4-1503014745.989892-372896200', '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 17:06:21 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 17:06:21 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 17:06:21 INFO - Using env: {'DISPLAY': ':0', 17:06:21 INFO - 'HOME': '/home/cltbld', 17:06:21 INFO - 'LANG': 'en_US.UTF-8', 17:06:21 INFO - 'LANGUAGE': 'en_US:en', 17:06:21 INFO - 'LOGNAME': 'cltbld', 17:06:21 INFO - 'MAIL': '/var/mail/cltbld', 17:06:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:06:21 INFO - 'MOZ_NO_REMOTE': '1', 17:06:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:06:21 INFO - 'NO_EM_RESTART': '1', 17:06:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:06:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:06:21 INFO - 'PWD': '/builds/slave/test', 17:06:21 INFO - 'SHELL': '/bin/bash', 17:06:21 INFO - 'SHLVL': '1', 17:06:21 INFO - 'TERM': 'linux', 17:06:21 INFO - 'TMOUT': '86400', 17:06:21 INFO - 'USER': 'cltbld', 17:06:21 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1503014745.989892-372896200', 17:06:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:06:21 INFO - '_': '/tools/buildbot/bin/python'} 17:06:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:06:21 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 17:06:21 INFO - Cleaning up... 17:06:21 INFO - Return code: 0 17:06:21 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 17:06:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:06:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:06:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:06:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:06:21 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 0x17a81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18aca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a4fc30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a4ccc0>, '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 0x1a4dcd0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a4e160>, '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': '20e666a3d4cfbb71505a330e000001b4-1503014745.989892-372896200', '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 17:06:21 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 17:06:21 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 17:06:21 INFO - Using env: {'DISPLAY': ':0', 17:06:21 INFO - 'HOME': '/home/cltbld', 17:06:21 INFO - 'LANG': 'en_US.UTF-8', 17:06:21 INFO - 'LANGUAGE': 'en_US:en', 17:06:21 INFO - 'LOGNAME': 'cltbld', 17:06:21 INFO - 'MAIL': '/var/mail/cltbld', 17:06:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:06:21 INFO - 'MOZ_NO_REMOTE': '1', 17:06:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:06:21 INFO - 'NO_EM_RESTART': '1', 17:06:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:06:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:06:21 INFO - 'PWD': '/builds/slave/test', 17:06:21 INFO - 'SHELL': '/bin/bash', 17:06:21 INFO - 'SHLVL': '1', 17:06:21 INFO - 'TERM': 'linux', 17:06:21 INFO - 'TMOUT': '86400', 17:06:21 INFO - 'USER': 'cltbld', 17:06:21 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1503014745.989892-372896200', 17:06:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:06:21 INFO - '_': '/tools/buildbot/bin/python'} 17:06:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:06:21 INFO - Downloading/unpacking psutil>=3.1.1 17:06:21 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 17:06:21 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 17:06:21 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 17:06:21 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 17:06:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:06:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:06:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:06:22 INFO - Installing collected packages: psutil 17:06:22 INFO - Running setup.py install for psutil 17:06:22 INFO - building 'psutil._psutil_linux' extension 17:06:22 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 17:06:22 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 17:06:23 INFO - building 'psutil._psutil_posix' extension 17:06:23 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 17:06:23 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 17:06:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:06:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:06:23 INFO - Successfully installed psutil 17:06:23 INFO - Cleaning up... 17:06:23 INFO - Return code: 0 17:06:23 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 17:06:23 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')]} 17:06:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:06:23 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')]} 17:06:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:06:23 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 0x17a81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18aca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a4fc30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a4ccc0>, '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 0x1a4dcd0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a4e160>, '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': '20e666a3d4cfbb71505a330e000001b4-1503014745.989892-372896200', '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 17:06:23 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 17:06:23 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 17:06:23 INFO - Using env: {'DISPLAY': ':0', 17:06:23 INFO - 'HOME': '/home/cltbld', 17:06:23 INFO - 'LANG': 'en_US.UTF-8', 17:06:23 INFO - 'LANGUAGE': 'en_US:en', 17:06:23 INFO - 'LOGNAME': 'cltbld', 17:06:23 INFO - 'MAIL': '/var/mail/cltbld', 17:06:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:06:23 INFO - 'MOZ_NO_REMOTE': '1', 17:06:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:06:23 INFO - 'NO_EM_RESTART': '1', 17:06:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:06:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:06:23 INFO - 'PWD': '/builds/slave/test', 17:06:23 INFO - 'SHELL': '/bin/bash', 17:06:23 INFO - 'SHLVL': '1', 17:06:23 INFO - 'TERM': 'linux', 17:06:23 INFO - 'TMOUT': '86400', 17:06:23 INFO - 'USER': 'cltbld', 17:06:23 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1503014745.989892-372896200', 17:06:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:06:23 INFO - '_': '/tools/buildbot/bin/python'} 17:06:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:06:23 INFO - Downloading/unpacking mozsystemmonitor==0.3 17:06:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:06:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:06:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:06:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:06:24 INFO - Downloading mozsystemmonitor-0.3.tar.gz 17:06:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:06:24 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 17:06:24 INFO - Installing collected packages: mozsystemmonitor 17:06:24 INFO - Running setup.py install for mozsystemmonitor 17:06:24 INFO - Successfully installed mozsystemmonitor 17:06:24 INFO - Cleaning up... 17:06:24 INFO - Return code: 0 17:06:24 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 17:06:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:06:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:06:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:06:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:06:24 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 0x17a81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18aca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a4fc30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a4ccc0>, '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 0x1a4dcd0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a4e160>, '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': '20e666a3d4cfbb71505a330e000001b4-1503014745.989892-372896200', '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 17:06:24 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 17:06:24 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 17:06:24 INFO - Using env: {'DISPLAY': ':0', 17:06:24 INFO - 'HOME': '/home/cltbld', 17:06:24 INFO - 'LANG': 'en_US.UTF-8', 17:06:24 INFO - 'LANGUAGE': 'en_US:en', 17:06:24 INFO - 'LOGNAME': 'cltbld', 17:06:24 INFO - 'MAIL': '/var/mail/cltbld', 17:06:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:06:24 INFO - 'MOZ_NO_REMOTE': '1', 17:06:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:06:24 INFO - 'NO_EM_RESTART': '1', 17:06:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:06:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:06:24 INFO - 'PWD': '/builds/slave/test', 17:06:24 INFO - 'SHELL': '/bin/bash', 17:06:24 INFO - 'SHLVL': '1', 17:06:24 INFO - 'TERM': 'linux', 17:06:24 INFO - 'TMOUT': '86400', 17:06:24 INFO - 'USER': 'cltbld', 17:06:24 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1503014745.989892-372896200', 17:06:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:06:24 INFO - '_': '/tools/buildbot/bin/python'} 17:06:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:06:24 INFO - Downloading/unpacking jsonschema==2.5.1 17:06:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:06:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:06:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:06:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:06:26 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:06:26 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 17:06:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:06:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:06:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:06:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:06:26 INFO - Downloading functools32-3.2.3-2.tar.gz 17:06:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:06:26 INFO - warning: no files found matching '*.txt' 17:06:26 INFO - no previously-included directories found matching 'build' 17:06:26 INFO - no previously-included directories found matching 'dist' 17:06:26 INFO - no previously-included directories found matching '.git*' 17:06:26 INFO - Installing collected packages: jsonschema, functools32 17:06:26 INFO - Running setup.py install for functools32 17:06:26 INFO - warning: no files found matching '*.txt' 17:06:26 INFO - no previously-included directories found matching 'build' 17:06:26 INFO - no previously-included directories found matching 'dist' 17:06:26 INFO - no previously-included directories found matching '.git*' 17:06:26 INFO - Successfully installed jsonschema functools32 17:06:26 INFO - Cleaning up... 17:06:26 INFO - Return code: 0 17:06:26 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 17:06:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:06:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:06:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:06:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:06:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x17a81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18aca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a4fc30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a4ccc0>, '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 0x1a4dcd0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a4e160>, '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': '20e666a3d4cfbb71505a330e000001b4-1503014745.989892-372896200', '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 17:06:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 17:06:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 17:06:26 INFO - Using env: {'DISPLAY': ':0', 17:06:26 INFO - 'HOME': '/home/cltbld', 17:06:26 INFO - 'LANG': 'en_US.UTF-8', 17:06:26 INFO - 'LANGUAGE': 'en_US:en', 17:06:26 INFO - 'LOGNAME': 'cltbld', 17:06:26 INFO - 'MAIL': '/var/mail/cltbld', 17:06:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:06:26 INFO - 'MOZ_NO_REMOTE': '1', 17:06:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:06:26 INFO - 'NO_EM_RESTART': '1', 17:06:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:06:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:06:26 INFO - 'PWD': '/builds/slave/test', 17:06:26 INFO - 'SHELL': '/bin/bash', 17:06:26 INFO - 'SHLVL': '1', 17:06:26 INFO - 'TERM': 'linux', 17:06:26 INFO - 'TMOUT': '86400', 17:06:26 INFO - 'USER': 'cltbld', 17:06:26 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1503014745.989892-372896200', 17:06:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:06:26 INFO - '_': '/tools/buildbot/bin/python'} 17:06:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:06:26 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 17:06:26 INFO - Cleaning up... 17:06:26 INFO - Return code: 0 17:06:26 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:06:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:06:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:06:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:06:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:06:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x17a81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18aca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a4fc30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a4ccc0>, '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 0x1a4dcd0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a4e160>, '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': '20e666a3d4cfbb71505a330e000001b4-1503014745.989892-372896200', '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 17:06:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 17:06:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 17:06:26 INFO - Using env: {'DISPLAY': ':0', 17:06:26 INFO - 'HOME': '/home/cltbld', 17:06:26 INFO - 'LANG': 'en_US.UTF-8', 17:06:26 INFO - 'LANGUAGE': 'en_US:en', 17:06:26 INFO - 'LOGNAME': 'cltbld', 17:06:26 INFO - 'MAIL': '/var/mail/cltbld', 17:06:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:06:26 INFO - 'MOZ_NO_REMOTE': '1', 17:06:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:06:26 INFO - 'NO_EM_RESTART': '1', 17:06:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:06:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:06:26 INFO - 'PWD': '/builds/slave/test', 17:06:26 INFO - 'SHELL': '/bin/bash', 17:06:26 INFO - 'SHLVL': '1', 17:06:26 INFO - 'TERM': 'linux', 17:06:26 INFO - 'TMOUT': '86400', 17:06:26 INFO - 'USER': 'cltbld', 17:06:26 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1503014745.989892-372896200', 17:06:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:06:26 INFO - '_': '/tools/buildbot/bin/python'} 17:06:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:06:26 INFO - Downloading/unpacking blobuploader==1.2.4 17:06:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:06:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:06:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:06:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:06:27 INFO - Downloading blobuploader-1.2.4.tar.gz 17:06:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:06:28 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:06:28 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 17:06:28 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 17:06:28 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 17:06:28 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 17:06:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:06:28 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:06:28 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 17:06:28 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 17:06:28 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 17:06:28 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 17:06:28 INFO - Downloading docopt-0.6.1.tar.gz 17:06:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:06:28 INFO - Installing collected packages: blobuploader, requests, docopt 17:06:28 INFO - Running setup.py install for blobuploader 17:06:28 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:06:28 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:06:28 INFO - Running setup.py install for requests 17:06:29 INFO - Running setup.py install for docopt 17:06:29 INFO - Successfully installed blobuploader requests docopt 17:06:29 INFO - Cleaning up... 17:06:29 INFO - Return code: 0 17:06:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:06:29 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')]} 17:06:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:06:29 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')]} 17:06:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:06:29 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 0x17a81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18aca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a4fc30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a4ccc0>, '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 0x1a4dcd0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a4e160>, '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': '20e666a3d4cfbb71505a330e000001b4-1503014745.989892-372896200', '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 17:06:29 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 17:06:29 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 17:06:29 INFO - Using env: {'DISPLAY': ':0', 17:06:29 INFO - 'HOME': '/home/cltbld', 17:06:29 INFO - 'LANG': 'en_US.UTF-8', 17:06:29 INFO - 'LANGUAGE': 'en_US:en', 17:06:29 INFO - 'LOGNAME': 'cltbld', 17:06:29 INFO - 'MAIL': '/var/mail/cltbld', 17:06:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:06:29 INFO - 'MOZ_NO_REMOTE': '1', 17:06:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:06:29 INFO - 'NO_EM_RESTART': '1', 17:06:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:06:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:06:29 INFO - 'PWD': '/builds/slave/test', 17:06:29 INFO - 'SHELL': '/bin/bash', 17:06:29 INFO - 'SHLVL': '1', 17:06:29 INFO - 'TERM': 'linux', 17:06:29 INFO - 'TMOUT': '86400', 17:06:29 INFO - 'USER': 'cltbld', 17:06:29 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1503014745.989892-372896200', 17:06:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:06:29 INFO - '_': '/tools/buildbot/bin/python'} 17:06:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:06:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:06:29 INFO - Running setup.py (path:/tmp/pip-QMkmvX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:06:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:06:29 INFO - Running setup.py (path:/tmp/pip-Te6DKK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:06:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:06:29 INFO - Running setup.py (path:/tmp/pip-_6P8iV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:06:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:06:29 INFO - Running setup.py (path:/tmp/pip-SOKhjw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:06:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:06:29 INFO - Running setup.py (path:/tmp/pip-bWQWUE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:06:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:06:29 INFO - Running setup.py (path:/tmp/pip-oAz3Zw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:06:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:06:29 INFO - Running setup.py (path:/tmp/pip-FhjnYl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:06:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:06:30 INFO - Running setup.py (path:/tmp/pip-1F1TTS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:06:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:06:30 INFO - Running setup.py (path:/tmp/pip-HZ83oo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:06:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:06:30 INFO - Running setup.py (path:/tmp/pip-VD29_o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:06:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:06:30 INFO - Running setup.py (path:/tmp/pip-nHayAh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:06:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:06:30 INFO - Running setup.py (path:/tmp/pip-QVAk2v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:06:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:06:30 INFO - Running setup.py (path:/tmp/pip-sTkyU5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:06:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:06:30 INFO - Running setup.py (path:/tmp/pip-yFyHNm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:06:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:06:30 INFO - Running setup.py (path:/tmp/pip-_TK_50-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:06:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:06:30 INFO - Running setup.py (path:/tmp/pip-Hg8Cfa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:06:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:06:30 INFO - Running setup.py (path:/tmp/pip-thIbaC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:06:30 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:06:30 INFO - Running setup.py install for manifestparser 17:06:30 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:06:30 INFO - Running setup.py install for mozcrash 17:06:30 INFO - Running setup.py install for mozdebug 17:06:31 INFO - Running setup.py install for mozdevice 17:06:31 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:06:31 INFO - Running setup.py install for mozfile 17:06:31 INFO - Running setup.py install for mozhttpd 17:06:31 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:06:31 INFO - Running setup.py install for mozinfo 17:06:31 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:06:31 INFO - Running setup.py install for mozInstall 17:06:31 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:06:31 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:06:31 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:06:31 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:06:31 INFO - Running setup.py install for mozleak 17:06:31 INFO - Running setup.py install for mozlog 17:06:31 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:06:31 INFO - Running setup.py install for moznetwork 17:06:31 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:06:31 INFO - Running setup.py install for mozprocess 17:06:31 INFO - Running setup.py install for mozprofile 17:06:32 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:06:32 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:06:32 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:06:32 INFO - Running setup.py install for mozrunner 17:06:32 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:06:32 INFO - Running setup.py install for mozscreenshot 17:06:32 INFO - Running setup.py install for moztest 17:06:32 INFO - Running setup.py install for mozversion 17:06:32 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:06:32 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:06:32 INFO - Cleaning up... 17:06:32 INFO - Return code: 0 17:06:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:06:32 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')]} 17:06:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:06:32 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')]} 17:06:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:06:32 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 0x17a81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18aca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a4fc30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a4ccc0>, '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 0x1a4dcd0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a4e160>, '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': '20e666a3d4cfbb71505a330e000001b4-1503014745.989892-372896200', '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 17:06:32 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 17:06:32 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 17:06:32 INFO - Using env: {'DISPLAY': ':0', 17:06:32 INFO - 'HOME': '/home/cltbld', 17:06:32 INFO - 'LANG': 'en_US.UTF-8', 17:06:32 INFO - 'LANGUAGE': 'en_US:en', 17:06:32 INFO - 'LOGNAME': 'cltbld', 17:06:32 INFO - 'MAIL': '/var/mail/cltbld', 17:06:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:06:32 INFO - 'MOZ_NO_REMOTE': '1', 17:06:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:06:32 INFO - 'NO_EM_RESTART': '1', 17:06:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:06:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:06:32 INFO - 'PWD': '/builds/slave/test', 17:06:32 INFO - 'SHELL': '/bin/bash', 17:06:32 INFO - 'SHLVL': '1', 17:06:32 INFO - 'TERM': 'linux', 17:06:32 INFO - 'TMOUT': '86400', 17:06:32 INFO - 'USER': 'cltbld', 17:06:32 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1503014745.989892-372896200', 17:06:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:06:32 INFO - '_': '/tools/buildbot/bin/python'} 17:06:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:06:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:06:32 INFO - Running setup.py (path:/tmp/pip-xsnHBY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:06:32 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)) 17:06:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:06:32 INFO - Running setup.py (path:/tmp/pip-QnJWAn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:06:32 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)) 17:06:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:06:32 INFO - Running setup.py (path:/tmp/pip-4lb9EJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:06:32 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)) 17:06:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:06:32 INFO - Running setup.py (path:/tmp/pip-4t_qEb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:06:33 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)) 17:06:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:06:33 INFO - Running setup.py (path:/tmp/pip-LQHEkf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:06:33 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)) 17:06:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:06:33 INFO - Running setup.py (path:/tmp/pip-TwLzKr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:06:33 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)) 17:06:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:06:33 INFO - Running setup.py (path:/tmp/pip-qAnUFm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:06:33 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)) 17:06:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:06:33 INFO - Running setup.py (path:/tmp/pip-wqr6Xl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:06:33 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)) 17:06:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:06:33 INFO - Running setup.py (path:/tmp/pip-QFEI2H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:06:33 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)) 17:06:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:06:33 INFO - Running setup.py (path:/tmp/pip-RZwWpq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:06:33 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)) 17:06:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:06:33 INFO - Running setup.py (path:/tmp/pip-jIozeE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:06:33 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)) 17:06:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:06:33 INFO - Running setup.py (path:/tmp/pip-P7a9cz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:06:33 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)) 17:06:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:06:33 INFO - Running setup.py (path:/tmp/pip-7hYbVe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:06:33 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)) 17:06:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:06:33 INFO - Running setup.py (path:/tmp/pip-d1Q0Jj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:06:33 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)) 17:06:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:06:33 INFO - Running setup.py (path:/tmp/pip-JJB3nk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:06:33 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)) 17:06:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:06:33 INFO - Running setup.py (path:/tmp/pip-oIYHtW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:06:33 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)) 17:06:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:06:33 INFO - Running setup.py (path:/tmp/pip-YdoYmq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:06:33 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)) 17:06:33 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)) 17:06:33 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)) 17:06:33 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)) 17:06:33 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)) 17:06:33 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)) 17:06:33 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)) 17:06:33 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:06:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:06:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:06:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:06:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:06:35 INFO - Downloading blessings-1.6.tar.gz 17:06:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:06:35 INFO - Installing collected packages: blessings 17:06:35 INFO - Running setup.py install for blessings 17:06:35 INFO - Successfully installed blessings 17:06:35 INFO - Cleaning up... 17:06:35 INFO - Return code: 0 17:06:35 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:06:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:06:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:06:35 INFO - Reading from file tmpfile_stdout 17:06:35 INFO - Current package versions: 17:06:35 INFO - argparse == 1.2.1 17:06:35 INFO - blessings == 1.6 17:06:35 INFO - blobuploader == 1.2.4 17:06:35 INFO - docopt == 0.6.1 17:06:35 INFO - functools32 == 3.2.3-2 17:06:35 INFO - jsonschema == 2.5.1 17:06:35 INFO - manifestparser == 1.1 17:06:35 INFO - mozInstall == 1.13 17:06:35 INFO - mozcrash == 1.0 17:06:35 INFO - mozdebug == 0.1 17:06:35 INFO - mozdevice == 0.51 17:06:35 INFO - mozfile == 1.2 17:06:35 INFO - mozhttpd == 0.7 17:06:35 INFO - mozinfo == 0.10 17:06:35 INFO - mozleak == 0.1 17:06:35 INFO - mozlog == 3.5 17:06:35 INFO - moznetwork == 0.27 17:06:35 INFO - mozprocess == 0.25 17:06:35 INFO - mozprofile == 0.28 17:06:35 INFO - mozrunner == 6.13 17:06:35 INFO - mozscreenshot == 0.1 17:06:35 INFO - mozsystemmonitor == 0.3 17:06:35 INFO - moztest == 0.8 17:06:35 INFO - mozversion == 1.4 17:06:35 INFO - psutil == 3.1.1 17:06:35 INFO - requests == 1.2.3 17:06:35 INFO - wsgiref == 0.1.2 17:06:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:06:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:06:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:06:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:06:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:06:35 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 0x17a81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18aca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a4fc30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a4ccc0>, '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 0x1a4dcd0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a4e160>, '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': '20e666a3d4cfbb71505a330e000001b4-1503014745.989892-372896200', '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 17:06:35 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 17:06:35 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 17:06:35 INFO - Using env: {'DISPLAY': ':0', 17:06:35 INFO - 'HOME': '/home/cltbld', 17:06:35 INFO - 'LANG': 'en_US.UTF-8', 17:06:35 INFO - 'LANGUAGE': 'en_US:en', 17:06:35 INFO - 'LOGNAME': 'cltbld', 17:06:35 INFO - 'MAIL': '/var/mail/cltbld', 17:06:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:06:35 INFO - 'MOZ_NO_REMOTE': '1', 17:06:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:06:35 INFO - 'NO_EM_RESTART': '1', 17:06:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:06:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:06:35 INFO - 'PWD': '/builds/slave/test', 17:06:35 INFO - 'SHELL': '/bin/bash', 17:06:35 INFO - 'SHLVL': '1', 17:06:35 INFO - 'TERM': 'linux', 17:06:35 INFO - 'TMOUT': '86400', 17:06:35 INFO - 'USER': 'cltbld', 17:06:35 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1503014745.989892-372896200', 17:06:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:06:35 INFO - '_': '/tools/buildbot/bin/python'} 17:06:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:06:35 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)) 17:06:35 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)) 17:06:35 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)) 17:06:35 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)) 17:06:35 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)) 17:06:35 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)) 17:06:35 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)) 17:06:35 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)) 17:06:35 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)) 17:06:35 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 17:06:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:06:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:06:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:06:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:06:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 17:06:37 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)) 17:06:37 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)) 17:06:37 INFO - Installing collected packages: simplejson 17:06:37 INFO - Running setup.py install for simplejson 17:06:37 INFO - building 'simplejson._speedups' extension 17:06:37 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 17:06:37 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 17:06:38 INFO - Successfully installed simplejson 17:06:38 INFO - Cleaning up... 17:06:38 INFO - Return code: 0 17:06:38 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:06:38 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')]} 17:06:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:06:38 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')]} 17:06:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:06:38 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 0x17a81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18aca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a4fc30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a4ccc0>, '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 0x1a4dcd0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a4e160>, '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': '20e666a3d4cfbb71505a330e000001b4-1503014745.989892-372896200', '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 17:06:38 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 17:06:38 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 17:06:38 INFO - Using env: {'DISPLAY': ':0', 17:06:38 INFO - 'HOME': '/home/cltbld', 17:06:38 INFO - 'LANG': 'en_US.UTF-8', 17:06:38 INFO - 'LANGUAGE': 'en_US:en', 17:06:38 INFO - 'LOGNAME': 'cltbld', 17:06:38 INFO - 'MAIL': '/var/mail/cltbld', 17:06:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:06:38 INFO - 'MOZ_NO_REMOTE': '1', 17:06:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:06:38 INFO - 'NO_EM_RESTART': '1', 17:06:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:06:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:06:38 INFO - 'PWD': '/builds/slave/test', 17:06:38 INFO - 'SHELL': '/bin/bash', 17:06:38 INFO - 'SHLVL': '1', 17:06:38 INFO - 'TERM': 'linux', 17:06:38 INFO - 'TMOUT': '86400', 17:06:38 INFO - 'USER': 'cltbld', 17:06:38 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1503014745.989892-372896200', 17:06:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:06:38 INFO - '_': '/tools/buildbot/bin/python'} 17:06:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:06:38 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 17:06:38 INFO - Cleaning up... 17:06:38 INFO - Return code: 0 17:06:38 INFO - Running post-action listener: _resource_record_post_action 17:06:38 INFO - Running post-action listener: _start_resource_monitoring 17:06:38 INFO - Starting resource monitoring. 17:06:38 INFO - [mozharness: 2017-08-18 00:06:38.336949Z] Finished create-virtualenv step (success) 17:06:38 INFO - [mozharness: 2017-08-18 00:06:38.337621Z] Running install step. 17:06:38 INFO - Running pre-action listener: _resource_record_pre_action 17:06:38 INFO - Running main action method: install 17:06:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:06:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:06:38 INFO - Reading from file tmpfile_stdout 17:06:38 INFO - Detecting whether we're running mozinstall >=1.0... 17:06:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:06:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:06:38 INFO - Reading from file tmpfile_stdout 17:06:38 INFO - Output received: 17:06:38 INFO - Usage: mozinstall [options] installer 17:06:38 INFO - Options: 17:06:38 INFO - -h, --help show this help message and exit 17:06:38 INFO - -d DEST, --destination=DEST 17:06:38 INFO - Directory to install application into. [default: 17:06:38 INFO - "/builds/slave/test"] 17:06:38 INFO - --app=APP Application being installed. [default: firefox] 17:06:38 INFO - mkdir: /builds/slave/test/build/application 17:06:38 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'] 17:06:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 17:06:56 INFO - Reading from file tmpfile_stdout 17:06:56 INFO - Output received: 17:06:56 INFO - /builds/slave/test/build/application/firefox/firefox 17:06:56 INFO - Running post-action listener: _resource_record_post_action 17:06:56 INFO - [mozharness: 2017-08-18 00:06:56.700692Z] Finished install step (success) 17:06:56 INFO - [mozharness: 2017-08-18 00:06:56.700942Z] Running setup-mitmproxy step. 17:06:56 INFO - Running pre-action listener: _resource_record_pre_action 17:06:56 INFO - Running main action method: setup_mitmproxy 17:06:56 INFO - Skipping: mitmproxy is not required 17:06:56 INFO - Running post-action listener: _resource_record_post_action 17:06:56 INFO - [mozharness: 2017-08-18 00:06:56.702191Z] Finished setup-mitmproxy step (success) 17:06:56 INFO - [mozharness: 2017-08-18 00:06:56.702409Z] Running run-tests step. 17:06:56 INFO - Running pre-action listener: _resource_record_pre_action 17:06:56 INFO - Running pre-action listener: _set_gcov_prefix 17:06:56 INFO - Running main action method: run_tests 17:06:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:06:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:06:56 INFO - Python 2.7.3 17:06:56 INFO - Return code: 0 17:06:56 INFO - grabbing minidump binary from tooltool 17:06:56 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')]} 17:06:56 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 0x1a4ccc0>, '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 0x1a4dcd0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a4e160>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:06:56 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 17:06:56 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 17:06:56 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 17:06:56 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:06:56 INFO - Return code: 0 17:06:56 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 17:06:56 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:06:56 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:06:56 INFO - ENV: RUST_BACKTRACE is now full 17:06:56 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 17:06:56 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:06:56 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/b0RIcHGxQVmCDF_P3NNDKg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-015', '--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 17:06:56 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/b0RIcHGxQVmCDF_P3NNDKg/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-015 --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 17:06:56 INFO - Using env: {'DISPLAY': ':0', 17:06:56 INFO - 'HOME': '/home/cltbld', 17:06:56 INFO - 'LANG': 'en_US.UTF-8', 17:06:56 INFO - 'LANGUAGE': 'en_US:en', 17:06:56 INFO - 'LOGNAME': 'cltbld', 17:06:56 INFO - 'MAIL': '/var/mail/cltbld', 17:06:56 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:06:56 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:06:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:06:56 INFO - 'MOZ_NO_REMOTE': '1', 17:06:56 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:06:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:06:56 INFO - 'NO_EM_RESTART': '1', 17:06:56 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:06:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:06:56 INFO - 'PWD': '/builds/slave/test', 17:06:56 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:06:56 INFO - 'RUST_BACKTRACE': 'full', 17:06:56 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 17:06:56 INFO - 'SHELL': '/bin/bash', 17:06:56 INFO - 'SHLVL': '1', 17:06:56 INFO - 'STYLO_FORCE_ENABLED': '1', 17:06:56 INFO - 'TERM': 'linux', 17:06:56 INFO - 'TMOUT': '86400', 17:06:56 INFO - 'USER': 'cltbld', 17:06:56 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1503014745.989892-372896200', 17:06:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:06:56 INFO - '_': '/tools/buildbot/bin/python'} 17:06:56 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/b0RIcHGxQVmCDF_P3NNDKg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-015', '--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 17:06:57 INFO - mozversion application_buildid: 20170817231714 17:06:57 INFO - mozversion application_changeset: a6a1f5c1d971dbee67ba6eec7ead7902351ddca2 17:06:57 INFO - mozversion application_display_name: Nightly 17:06:57 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:06:57 INFO - mozversion application_name: Firefox 17:06:57 INFO - mozversion application_remotingname: firefox 17:06:57 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 17:06:57 INFO - mozversion application_vendor: Mozilla 17:06:57 INFO - mozversion application_version: 57.0a1 17:06:57 INFO - mozversion platform_buildid: 20170817231714 17:06:57 INFO - mozversion platform_changeset: a6a1f5c1d971dbee67ba6eec7ead7902351ddca2 17:06:57 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 17:06:57 INFO - mozversion platform_version: 57.0a1 17:06:57 INFO - using testdate: 1503014817 17:06:57 INFO - actual date: 1503014817 17:06:57 INFO - starting webserver on 'localhost:47786' 17:06:57 INFO - SUITE-START | Running 2 tests 17:06:57 INFO - TEST-START | dromaeo_css 17:06:57 INFO - Initialising browser for dromaeo_css test... 17:06:57 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:47786/getInfo.html -profile /tmp/tmph3Vhu0/profile 17:06:57 INFO - TEST-INFO | started process 8093 (/builds/slave/test/build/application/firefox/firefox http://localhost:47786/getInfo.html) 17:07:02 INFO - TEST-INFO | 8093: exit 0 17:07:02 INFO - Browser initialized. 17:07:02 INFO - Running cycle 1/1 for dromaeo_css test... 17:07:02 INFO - TEST-INFO | started process 8284 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmph3Vhu0/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 17:07:03 INFO - PID 8284 | 17:07:03 INFO - PID 8284 | (/builds/slave/test/build/application/firefox/firefox:8338): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 17:07:03 INFO - PID 8284 | 17:07:13 INFO - PID 8284 | RSS: Main: 169820160 17:07:13 INFO - PID 8284 | 17:10:13 INFO - PID 8284 | Cycle 1(1): loaded http://localhost:47786/tests/dromaeo/cssquery-dojo.html (next: http://localhost:47786/tests/dromaeo/cssquery-ext.html) 17:10:14 INFO - PID 8284 | RSS: Main: 174669824 17:10:14 INFO - PID 8284 | 17:13:16 INFO - PID 8284 | Cycle 1(1): loaded http://localhost:47786/tests/dromaeo/cssquery-ext.html (next: http://localhost:47786/tests/dromaeo/cssquery-jquery.html) 17:13:16 INFO - PID 8284 | RSS: Main: 172204032 17:13:16 INFO - PID 8284 | 17:16:18 INFO - PID 8284 | Cycle 1(1): loaded http://localhost:47786/tests/dromaeo/cssquery-jquery.html (next: http://localhost:47786/tests/dromaeo/cssquery-mootools.html) 17:16:19 INFO - PID 8284 | RSS: Main: 174727168 17:16:19 INFO - PID 8284 | 17:19:21 INFO - PID 8284 | Cycle 1(1): loaded http://localhost:47786/tests/dromaeo/cssquery-mootools.html (next: http://localhost:47786/tests/dromaeo/cssquery-prototype.html) 17:19:21 INFO - PID 8284 | RSS: Main: 170569728 17:19:21 INFO - PID 8284 | 17:22:25 INFO - PID 8284 | Cycle 1(1): loaded http://localhost:47786/tests/dromaeo/cssquery-prototype.html (next: http://localhost:47786/tests/dromaeo/cssquery-yui.html) 17:22:25 INFO - PID 8284 | RSS: Main: 176029696 17:22:25 INFO - PID 8284 | 17:25:27 INFO - PID 8284 | Cycle 1(1): loaded http://localhost:47786/tests/dromaeo/cssquery-yui.html (next: http://localhost:47786/tests/dromaeo/cssquery-dojo.html) 17:25:28 INFO - PID 8284 | RSS: Main: 176599040 17:25:28 INFO - PID 8284 | 17:25:28 INFO - PID 8284 | __start_tp_report 17:25:28 INFO - PID 8284 | _x_x_mozilla_page_load 17:25:28 INFO - PID 8284 | _x_x_mozilla_page_load_details 17:25:28 INFO - PID 8284 | |i|pagename|runs| 17:25:28 INFO - PID 8284 | |0;dojo.html;3133.8119712817233;3146.4493713600114;3167.3190264093223;3174.936501269974;3206.983965080174;6119.7246123924415;6126.326104128542;6180.072989051639;6199.4110559496885;6222.875542489148;6131.754729810813;6133.264008318997;6160.907586386196;6235.469985051276;6273.278572964111;5584.720763961806;5613.354464236604;5681;5703.287089113861;5740.196372507852;5479.123340265558;5552.472515111058;5556.749946252408;5699.2590963174725;5715.514181294595;5659.745311460994;5719.742611582489;5750.539956803466;5751.942480575203;5759.913601295942;5662.263905692274;5672.290963629546;5725.312962444492;5725.742341594639;5761.337446193657;5484.945150548523;5551;5583.274174357308;5619.353774315924;5644.915326270109;6105.45050945417;6167.660778657172;6174.320824709278;6194.845128871769;6202.782902598433;6640.667966601651;6690.498212634023;6705.128333316687;6719.294474080249;6730.360615741497;6687.364700353459;6692.63190524521;6713.597184168965;6805.421539169177;6810.216825065131;6087.817365479043;6189.659568723719;6258.968705156445;6267.5299352548745;6292.33930437302;6781.966090169518;6790.456763458911;6792.76225332111;6797.456203503708;6814;6358.109864618957;6439.452646525004;6445.742170313229;6448.065030570541;6453.128827608213;6539.901901471481;6544.934550654432;6547.377999090078;6550.148480697574;6561.770338038241;6509.707063182168;6525.967370163119;6546.639934803537;6576.638284894377;6578.440832529289;6607.537472376887;6675.499337549703;6697.531172817856;6701.530892837454;6702.36327548882;5380.435054319319;5417.241586177938;5463.098588732894;5478.616496845262;5486.753096110605;4611.584957353787;4629.25931850909;4648.83729069481;4656.068786242765;4679.81280748773;5779.942200578024;5799.594028417971;5809.24479817621;5823.126531020296;5824.126381042877;6713.69788359525;6777.220619628707;6788.083608712761;6800.557963732342;6805;5773.364929857712;5796.739146738407;5829.47534721877;5849.561282903799;5871.236739223874;5790.826275211751;5827.35899051104;5860.208871802252;5873.412658734178;5959.880802383928;6361.077643741632;6361.968190159112;6382.170317858741;6391.42477177047;6395.648239346788;6511.47908167336;6523.543351965317;6546.639934803631;6582.934170658232;6600.339966003553;6421.197350331208;6436.420722135031;6463.062855885964;6497.415232629086;6510.934890651033;6548.148740663683;6583.604983700993;6645.069690243273;6660.1341825564305;6664.266930637723;6545.181852268466;6663.666816659051;6679.933200668125;6717.395434410926;6813.216480104851;6455.644939528371;6462.095306656977;6487.383698548819;6492.805215843532;6500.252470965899;6442.291347951816;6466.708998095191;6468.15913931186;6474.417302442803;6484.773032944013;5501.115271427173;6379.93620063812;6423.871522569429;6494.707738151889;6507.511936604868;6521.087047813405;6574.737010519526;6585.506087043586;6588.967055164693;6664.50016248793;6205.596636218631;6290;6348.619082855043;6438.259600146043;6447.387498187664 17:25:28 INFO - PID 8284 | |1;ext.html;804.2600807257322;827.5655280977489;848.3552500099923;871.9084496127911;875.277895736018;39430.40854387183;40204.19591608166;40218.79890600547;40221;40253.59746402535;37096.81451592745;37188.25623487528;37381.62618373815;37411;37418.8129059355;6647.933520664804;6742.52802303839;6758.1214442122455;6779.559328643647;6806.4554835613035;6701.932980670204;6784.72861085556;6786.762463313785;6798.52410331277;6803.523753337268;7437.888431673529;7621.8475630487355;7660.2722741339485;7688.654010569509;7692.384609231248;7538.773836784905;7619;7630.198829122945;7632.274933881273;7651.693932242703;7267.418606511466;7474.85050298991;7494.475386722932;7516.473846830724;7544.547327160388;37313.25373492542;37918.43122353167;38032;38053.619463805284;38180.42729359062;3478.286951175028;3520.06718219672;3543.4684797280356;3556.6798988091195;3557.1996300832366;31025.534616980764;31110.377792444026;31134.688653113404;31135.37729245425;31222.843885780425;4828.348172996635;4868.05073010763;4889.75551222441;4890.144224760688;4932.654714170009;177989.1100544489;180635;188179;189064;208389;50063.49936500661;50313.49686503088;50365.244521332206;50410.49589504131;50411.49588504068;52398.21402678963;52597;52607.15874944435;52711.472885271425;52736.36318184152;15703.371865125268;15796.210189490479;15805;15812.525624231292;16034;13082.345882705828;13092.934535327262;13108.410121544553;13171.078024538381;13187.142835715647;14351.641208969859;14374.209418481874;14390.06464579799;14467.638309042359;14526.128432294096;5756.395578464201;5892.734826932799;5910.497607703307;5956.761729530857;6023.156758053876;987.9456629885425;999.7750506136061;1005.7686732051523;1021.5300961557618;1026.625281772148;22963.655545166836;29000.27499312492;29277.85361073181;30164.54753178704;30298.84850575733;1083.6315652678127;1085.7394225385851;1087.7008822573698;1091.2906610703108;1096.4846522134585;12278;12695.04787140968;12809.807852882213;12884.549040783715;12915.806262906064;231961;233959;234042;235005;235598;51539.48460515422;51545;51854;51933.740331298104;52095.73952130291;1454.1057249791513;1463.8902082343866;1492.1047371577183;1497.7907586310323;1505.5784380373514;22729.88635056814;22848.31455056351;22878.65682014738;23123.88438057799;23159.421014474774;34487.65512344844;34647.82676086603;34666.48000280048;34672.65327346795;34698.65301347055;196590;197685;197717;197870;198432;34185.31629367349;36612.26775464529;37414;37449.81275093607;37577.81211093927;46151.53848461472;46199.53800461952;46594.76702616465;46742.76628616835;47117.52882471131;34621.65378346285;34723.4791478123;34808.82595587006;34954.825225873705;35495;33727.49408758822;33826.83086584551;33985;34073.65926340804;34393.140171495914;37045;37132.81433592923;37141;37312;37430;32485.675143248263;32545.186370339983;32547.34905301928;32594.83702581567;32805.17987050343;23887.402814929766;24978.50042999166;25339.55582561724;25492.490150197264;25611.615825762256 17:25:28 INFO - PID 8284 | |2;jquery.html;553.4410245651893;567.1039757183651;574.2247965246916;577.3937365765945;585.6866576381636;21669;22360.776392236072;22382.104715811347;22498.66252006217;22984.19555315564;26668.19995400141;26948.056818011373;26992.190234292953;27011.594826077577;27413.86293068537;6387.744490220397;6541.934580654204;6542.901856472156;6544;6568.146141001687;5882.588218824684;6379.681015949184;6395.61626302421;6402.839929001766;6473.093766872642;6337.302896681362;6341.04884267359;6342.39747224013;6361.68191590421;6369.872602547946;6302.306746257908;6324.083007963843;6331.873362532747;6340.397662222082;6342.682865856688;5903.291605007426;5919.437653422961;5921.733521991478;5929.229200203989;5930.0808374701555;28406.289842754097;29246.70753292461;29756.40487190244;29919.850400748073;30190.698093019008;1911.9713204301947;1947.5423275530238;1949.6685563454105;1950.044478205669;1950.4928718533142;19300.80699193004;19880;19900.20399184031;19931.90034049835;19946.80053199464;2331.673565700786;2350.7884290413945;2383.1420688552107;2424.4544977380124;2425.514897020585;144128.27935860358;145345;147520;148149;149116;14586.635334116732;15424.691506170038;15526.534203973899;15640.139792311533;15758.68482630341;23769;23773.524529509312;23800.285991420285;23801.880990595284;23818.52362952766;10421;10475.52860121281;10533.84199237012;10589.199836027894;10745.892541074489;8696.826063478695;9754.024597540189;9785.07041831025;9810.75473113178;9884.752881177885;8257.339412846957;9274.397164184307;9400.48297343639;9527.809023872016;9611.375260608038;2643.603459481055;2676.7189445108374;2751.9724802751716;2847.25971247473;2861.7996740227986;979.7109852593502;996.6163027234567;1010.7169992402139;1017.2929813779352;1020.5764607687875;20366;20785.688214676793;20795.896020519802;20869;20976.37070887876;1054.6097943760703;1057.370864335719;1059.86751656043;1070.5236169904474;1088.8203446431407;11242.831357529643;11693.239939403911;11707.360879673657;11748.353840538852;13680.384382702803;512559.6676586287;523488;536526;541136;545941;124403;124728.37635811763;125573;126691;127139.36430317789;1271.3643178410794;1271.5676669932268;1309.4762095162012;1318.45284207053;1327.6548097494722;21712.782872171076;21775.346739597837;21900.561988760455;22031.33905982823;22163.22428714987;59073.11390329063;59744.40255597388;59781;60125.69937150461;61071;75811;76037.23962760523;76063;76139;77548.61225693836;14924.104553726811;14953.102813831205;15052.397904084151;15086.17026063577;15138.697226055638;23743.643845341987;23875.283741487783;23902;24061.639075414234;24067.879660601586;18631.72052419188;18935.810641893404;18999.33502327467;19052.523686907385;19081.141348639067;16667.66664666724;17088.316467341167;17225.483235502954;17431.389901353392;17452.301907923542;18871.622567548846;19289.324873629357;19324;19356.90321548383;19365.61268774645;14212.857871421153;14808.703825923205;14824.7776283358;14865.108093514424;14872.702545949236;18713;19015.52461188481;19054.42836714901;19079.332223372116;19130.330438434587 17:25:28 INFO - PID 8284 | |3;mootools.html;1362.8977826663;1411.0475429085366;1418.1136789506554;1425.6293363725442;1438.9280535973205;13588.592342229736;13649.931750341259;14215.289235538234;14251.788597969173;14274.857251427482;14391.856081439182;14590.927045364784;14629.195394253311;14651.780223296633;14680;2670.626112344273;2734.398432344891;2734.53512902806;2736.192823117185;2737.575675770249;2648.9470210595778;2702.162329677806;2703.648525691657;2706.134037108126;2746.5468197747346;2593.8962441502413;2652.5225459417297;2676.397810492643;2706;2728.590711393287;2583.767460928516;2605.7654811067;2621.580547112472;2642.2469596165192;2667.413169102794;2606.374470127175;2626.4353164069626;2627;2628.3823301524126;2630.224083895236;13642.317884105754;13790.172589644653;13818.86181138196;13832.170069795844;13977.091489053179;7313;7637.885431718529;7654.158042615308;7654.808629784245;7660.463767536275;4761.381020467317;4885.706857588556;4941.876453088666;5061.620378471593;5067.974660126676;1741;1779.7686300780815;1788.6243888783372;1789.910504474771;1806.0879255975779;22731.431714207112;22837.657435138488;22929.31212063624;22931.197408090637;23041.654375184386;6130.356312587203;6281.748730050838;6429.431665425734;6481.546291759531;6486.967565162144;15698.9215053924;15758.212089395485;15767.369305227892;15769.44806931752;15830.60423489399;7163.820904477326;7444.106707195171;7468.066491688539;7488.700451981859;7533.472656913963;5691.8292451226525;6032.306284777219;6242.1261023455845;6260.154879091356;7146.678399472036;5045.117104506697;5176.50823171798;5180.559652429511;5228.137357335997;5289.70906600133;1465.8900582456358;1506.284514855435;1509.9698006039819;1524.885633577486;1530.1737061986403;878.9560521973875;900.6397441023512;900.8513595256841;905.6196397513061;910.5083255042204;7148.285171482914;7205.279472052857;7225;7246.601436920914;7294.513873967472;700.8837659898364;712.6080655639378;719.9856002879914;737.2038198745342;750.7297372945735;4636.5752070077415;5385.434529374437;5407.297051383373;5424.376196737347;5519.31008623922;18968.24127034903;19759.60480790376;19781;19937.800621993883;19974.30089946845;19428.902855485914;19835.801641983395;19928;19938.20247190125;20031;10042.648507302209;10797.136229101652;10829.783404331869;10851.67444976652;10892.183086268562;8001.951695535459;8074.475159114639;8109.837803243784;8129.227723366271;8271.54506502148;16671.333146674;16764.1617919106;16812.747808782635;17041.147942603067;17630;17268.30926762966;17332.91333543324;17349.479515614552;17443.30226790914;17705.557361066076;11561.364124973206;11806.704832379259;11817.409129543661;11861.05111591088;11881.762364752483;13049;13257.403416846459;13311.068225224528;13312.46750129984;13425.328733563087;10749.355038697704;10785.946070269598;10824.67525974222;11002;11062.612808551663;9899.307048506535;10604.416757078434;10831.18766092562;10881.075108615856;11010.834837477283;9752.951235243778;9842.409455432411;9936.900630993598;9943.900560994298;9948.701538953843;7005.54463959841;7042.753503627348;7073;7156.534825236343;7220.74727384539;7540.773776786705;7594.240575942362;7608.885866712115;7619.961900190464;7689.077310722749 17:25:28 INFO - PID 8284 | |4;prototype.html;497.5074676070691;502.84411832331966;510.5150107397972;518.7535920437792;520.5211205690764;6249.968750156254;6258.5306102042305;6300.968495157524;6318.399752023556;6341.524385671076;6103.786367477139;6156.41514056165;6193.659348735818;6222.253329600443;6225.564210505267;4922.138625740481;5020.799168033274;5049.596032317424;5083.466236045218;5084.949150508503;4970.86252911248;4980.128477516439;5011.42368627607;5018.673786203904;5045.192769156935;4991.326170966928;4994;5005.549500544968;5025.170846810291;5027.321311622939;5002;5020.314131939395;5043.924341134886;5052.696838189684;5062.873428164288;4519.661025423106;4531.9803044315095;4539.546045395434;4544.818207271705;4569.611583015414;6018.368071352533;6076.210092687967;6079.574429789916;6103.664298463583;6169.598976066542;5742.770289188427;5764.769409223626;5769.740361683735;5793.681347525884;5800.332961709415;6609.109259148196;6654.6672666366485;6694.83262918426;6702.497312701566;6703.927371620517;4884.804607815683;4894.7063176209185;4916.532929371704;4962.635275299322;4984.127777638899;6611.272759996396;6756.662166891636;6781.62701051437;6930.480213983921;6989.3870045769545;5008;5010.674306170087;5020.246962955513;5020.899582008339;5034.34553508049;5070.670406423571;5086.821961231413;5109.489051094935;5131.307273518102;5143.8456846294675;5739.196512488255;5748.856278592985;5764.204360884967;5774.191613174159;5784.652920824764;6582.63795491243;6642.671465706878;6674.666266686743;6688.699008544627;6710.899336509956;1788.9642207155784;1811.2664370929795;1816.6457540779686;1822.1526989949737;1825.1239405085632;1196.4496331687521;1229.305442425027;1245.9813102803466;1253.7053792358788;1260.3950103950156;5730.541556675456;5838.9124163137585;5860.633827798232;5909.556783241274;5934.258217722785;6771.796846094625;6795.524313298021;6807.863842723118;6884.277150899184;6894.931050689429;5737.876985515386;5765.769369225268;5809.331926828384;5850.765969361178;5870.236869206976;3572.5891522474726;3610.05057269077;3627.093226693327;3664.926701466009;3683.963160368362;6478.380404898775;6606.711691220262;6624.370684784938;6630.370114839083;6679.432248258855;6771.239477735726;6811.761588344483;6931.306869313028;6965.756198533027;6982.47631427645;6131.3897684051435;6538.673066346759;6581.301666316883;6591.187423458491;6623.503237257321;6819.4656202356055;6854.280300568568;6889.345512176335;6920.996455514023;6930.861382772216;6721.630310332978;6726.939242644487;6737.898931515933;6748.392644662004;6847.931520684929;6542.640154791532;6605.801825945229;6631.469482441489;6637.734490620514;6667.43326817226;5023.01590871611;5038.622103342191;5059.696418214919;5078.898422031465;5104.132297509506;6601.207855057424;6665.40011398957;6690.951974055626;6849.8972515411315;6934.653267336512;6578.506612004023;6581.835454113685;6614.173228346457;6626.701798419179;6644.202695676549;6466.902996454963;6514.413702766774;6596.868062638624;6627.502937279627;6633.635150066792;6489.1888513935755;6511.544191906521;6550.63971481554;6554.673091052608;6584.703688333941;6581.157275962738;6616.966915165393;6674.16572928384;6709.563878347892;6730.32696730323;6456.644884531208;6463.289038205888;6471.676416179078;6478.643674597943;6532.967335163484 17:25:28 INFO - PID 8284 | |5;yui.html;911.9817603647928;913.8218047480741;930.0467021303159;935.6351023100988;939.0421769794807;19042.809571904276;20006.59986800263;20007.899960500214;20011.899940500294;22239.555208895854;21950.231741889038;21970.89014554929;22213.22253721116;22314.665280020814;22404.88797556014;968.7093871838456;985.9605615775396;989.6635144051021;991.013941128578;991.6628346362236;975.8877729061178;1060.3690803971624;1060.3849767135043;1062.8405739139153;1063.2291588598282;1103.9944800275987;1118.664400679797;1120.966371008871;1121.2375584602466;1122.3490375582185;1099.2964502718266;1113.4432783608195;1113.62136873463;1113.6492005018392;1116.2521110855664;797.8603744344716;801.1787917384727;807.8182408957996;808.1998821167002;808.6361137488095;20220.39338819838;20475.5904881903;20536.79463205379;20574.074166662536;20975.16099356024;21780.89109554458;21888.671669924963;22174.223902163507;22396.55206895853;22399.440013999618;16516;16587.170641467877;16786.83213167865;16944.49166525006;17049.65900681992;3649.6897763690117;3669.889903302905;3672.4124140137715;3673.4673472346362;3673.5775385830702;122779;124437;126392.36803816106;127162;127525;16896.831031689773;17279.481615551555;17330.220140093727;17360.65278694419;17717.55706107332;31123.533147002814;31694.524582131286;31749.682503175136;31847;32263.51604725931;8004.399670024772;8338;8347.582620868932;8965.327600429993;9092.545372731469;4276.18752437036;4456.353828694886;4460.799264033127;4465.307877279027;4479.260921947842;5248.186531087687;5358.035553600389;5406.83779486616;5785.623934444247;6016.067509536029;1049.8687664041995;1052.5421441672897;1083.7778255457613;1088.3089238333714;1091.781643671269;687.29895506584;711.3100292716057;713.12642013533;717.4153065251803;721.4192574977194;12123.515059397701;12590.24458532491;12697.746045079231;13354.866451335361;13371.866281337063;610.5237914426755;635.2028204603286;667.6027763480721;724.5399171526119;737.0823324960459;5526.143447765603;5830.679312637845;5882.55880808941;5932.79235226765;6094.725737341831;103114;103144.96855031504;106686.46656766666;106946.46526767472;109674.45162774295;94876;95137.52431237938;96699;99532.50233748785;100257;85157;85611.5719421399;85983.14016859877;88515;89346;10725.249232553646;10736.033756961911;10759.623413180501;10800.567977281135;11034.668959930894;39160;39650.20699585934;39824.80087599543;39857.40213896852;39927.401088983104;69033.3096669047;69413.30586694069;69531;70395;71967.28032719606;19223.807761922202;19381.321653742052;19580.804191957897;19614.803851961868;19627.116779745233;22175.667364989862;22759.203427879944;22772.886135569217;22920.77079229253;23013.53972920566;19435.028248587798;19968.800311996692;19995.400137995883;20238.595228095062;20245.49386265355;20450.181992720125;20668.689969650168;20673.276435324693;20735.688964665846;20834.374968750963;18225.45323640293;18573;18649.254029839198;19769.703454447907;20102.597948040664;12951.805722914352;13306.800397993844;14484.130952142905;14640.633984150056;14999.100053996795;14577.489787857798;14617.707645846811;15208.163551004802;15394.07635541871;15536.84463155354 17:25:28 INFO - PID 8284 | __end_tp_report 17:25:28 INFO - PID 8284 | __start_cc_report 17:25:28 INFO - PID 8284 | _x_x_mozilla_cycle_collect,358 17:25:28 INFO - PID 8284 | __end_cc_report 17:25:28 INFO - PID 8284 | __startTimestamp1503015928013__endTimestamp 17:25:28 INFO - PID 8284 | 17:25:28 INFO - PID 8284 | ------- Summary: start ------- 17:25:28 INFO - PID 8284 | Number of tests: 6 17:25:28 INFO - PID 8284 | 17:25:28 INFO - PID 8284 | [#0] dojo.html Cycles:165 Average:6116.07 Median:6379.94 stddev:715.63 (11.2%) stddev-sans-first:678.51 17:25:28 INFO - PID 8284 | Values: 3133.8 3146.4 3167.3 3174.9 3207.0 6119.7 6126.3 6180.1 6199.4 6222.9 6131.8 6133.3 6160.9 6235.5 6273.3 5584.7 5613.4 5681.0 5703.3 5740.2 5479.1 5552.5 5556.7 5699.3 5715.5 5659.7 5719.7 5750.5 5751.9 5759.9 5662.3 5672.3 5725.3 5725.7 5761.3 5484.9 5551.0 5583.3 5619.4 5644.9 6105.5 6167.7 6174.3 6194.8 6202.8 6640.7 6690.5 6705.1 6719.3 6730.4 6687.4 6692.6 6713.6 6805.4 6810.2 6087.8 6189.7 6259.0 6267.5 6292.3 6782.0 6790.5 6792.8 6797.5 6814.0 6358.1 6439.5 6445.7 6448.1 6453.1 6539.9 6544.9 6547.4 6550.1 6561.8 6509.7 6526.0 6546.6 6576.6 6578.4 6607.5 6675.5 6697.5 6701.5 6702.4 5380.4 5417.2 5463.1 5478.6 5486.8 4611.6 4629.3 4648.8 4656.1 4679.8 5779.9 5799.6 5809.2 5823.1 5824.1 6713.7 6777.2 6788.1 6800.6 6805.0 5773.4 5796.7 5829.5 5849.6 5871.2 5790.8 5827.4 5860.2 5873.4 5959.9 6361.1 6362.0 6382.2 6391.4 6395.6 6511.5 6523.5 6546.6 6582.9 6600.3 6421.2 6436.4 6463.1 6497.4 6510.9 6548.1 6583.6 6645.1 6660.1 6664.3 6545.2 6663.7 6679.9 6717.4 6813.2 6455.6 6462.1 6487.4 6492.8 6500.3 6442.3 6466.7 6468.2 6474.4 6484.8 5501.1 6379.9 6423.9 6494.7 6507.5 6521.1 6574.7 6585.5 6589.0 6664.5 6205.6 6290.0 6348.6 6438.3 6447.4 17:25:28 INFO - PID 8284 | 17:25:28 INFO - PID 8284 | [#1] ext.html Cycles:180 Average:37936.50 Median:19519.23 stddev:53863.26 (275.9%) stddev-sans-first:53942.19 17:25:28 INFO - PID 8284 | Values: 804.3 827.6 848.4 871.9 875.3 39430.4 40204.2 40218.8 40221.0 40253.6 37096.8 37188.3 37381.6 37411.0 37418.8 6647.9 6742.5 6758.1 6779.6 6806.5 6701.9 6784.7 6786.8 6798.5 6803.5 7437.9 7621.8 7660.3 7688.7 7692.4 7538.8 7619.0 7630.2 7632.3 7651.7 7267.4 7474.9 7494.5 7516.5 7544.5 37313.3 37918.4 38032.0 38053.6 38180.4 3478.3 3520.1 3543.5 3556.7 3557.2 31025.5 31110.4 31134.7 31135.4 31222.8 4828.3 4868.1 4889.8 4890.1 4932.7 177989.1 180635.0 188179.0 189064.0 208389.0 50063.5 50313.5 50365.2 50410.5 50411.5 52398.2 52597.0 52607.2 52711.5 52736.4 15703.4 15796.2 15805.0 15812.5 16034.0 13082.3 13092.9 13108.4 13171.1 13187.1 14351.6 14374.2 14390.1 14467.6 14526.1 5756.4 5892.7 5910.5 5956.8 6023.2 987.9 999.8 1005.8 1021.5 1026.6 22963.7 29000.3 29277.9 30164.5 30298.8 1083.6 1085.7 1087.7 1091.3 1096.5 12278.0 12695.0 12809.8 12884.5 12915.8 231961.0 233959.0 234042.0 235005.0 235598.0 51539.5 51545.0 51854.0 51933.7 52095.7 1454.1 1463.9 1492.1 1497.8 1505.6 22729.9 22848.3 22878.7 23123.9 23159.4 34487.7 34647.8 34666.5 34672.7 34698.7 196590.0 197685.0 197717.0 197870.0 198432.0 34185.3 36612.3 37414.0 37449.8 37577.8 46151.5 46199.5 46594.8 46742.8 47117.5 34621.7 34723.5 34808.8 34954.8 35495.0 33727.5 33826.8 33985.0 34073.7 34393.1 37045.0 37132.8 37141.0 37312.0 37430.0 32485.7 32545.2 32547.3 32594.8 32805.2 23887.4 24978.5 25339.6 25492.5 25611.6 17:25:28 INFO - PID 8284 | 17:25:28 INFO - PID 8284 | [#2] jquery.html Cycles:180 Average:37031.96 Median:22440.38 stddev:89658.47 (399.5%) stddev-sans-first:89868.15 17:25:28 INFO - PID 8284 | Values: 553.4 567.1 574.2 577.4 585.7 21669.0 22360.8 22382.1 22498.7 22984.2 26668.2 26948.1 26992.2 27011.6 27413.9 6387.7 6541.9 6542.9 6544.0 6568.1 5882.6 6379.7 6395.6 6402.8 6473.1 6337.3 6341.0 6342.4 6361.7 6369.9 6302.3 6324.1 6331.9 6340.4 6342.7 5903.3 5919.4 5921.7 5929.2 5930.1 28406.3 29246.7 29756.4 29919.9 30190.7 1912.0 1947.5 1949.7 1950.0 1950.5 19300.8 19880.0 19900.2 19931.9 19946.8 2331.7 2350.8 2383.1 2424.5 2425.5 144128.3 145345.0 147520.0 148149.0 149116.0 14586.6 15424.7 15526.5 15640.1 15758.7 23769.0 23773.5 23800.3 23801.9 23818.5 10421.0 10475.5 10533.8 10589.2 10745.9 8696.8 9754.0 9785.1 9810.8 9884.8 8257.3 9274.4 9400.5 9527.8 9611.4 2643.6 2676.7 2752.0 2847.3 2861.8 979.7 996.6 1010.7 1017.3 1020.6 20366.0 20785.7 20795.9 20869.0 20976.4 1054.6 1057.4 1059.9 1070.5 1088.8 11242.8 11693.2 11707.4 11748.4 13680.4 512559.7 523488.0 536526.0 541136.0 545941.0 124403.0 124728.4 125573.0 126691.0 127139.4 1271.4 1271.6 1309.5 1318.5 1327.7 21712.8 21775.3 21900.6 22031.3 22163.2 59073.1 59744.4 59781.0 60125.7 61071.0 75811.0 76037.2 76063.0 76139.0 77548.6 14924.1 14953.1 15052.4 15086.2 15138.7 23743.6 23875.3 23902.0 24061.6 24067.9 18631.7 18935.8 18999.3 19052.5 19081.1 16667.7 17088.3 17225.5 17431.4 17452.3 18871.6 19289.3 19324.0 19356.9 19365.6 14212.9 14808.7 14824.8 14865.1 14872.7 18713.0 19015.5 19054.4 19079.3 19130.3 17:25:28 INFO - PID 8284 | 17:25:28 INFO - PID 8284 | [#3] mootools.html Cycles:180 Average:8747.01 Median:2627.69 stddev:6009.09 (228.7%) stddev-sans-first:6000.33 17:25:28 INFO - PID 8284 | Values: 1362.9 1411.0 1418.1 1425.6 1438.9 13588.6 13649.9 14215.3 14251.8 14274.9 14391.9 14590.9 14629.2 14651.8 14680.0 2670.6 2734.4 2734.5 2736.2 2737.6 2648.9 2702.2 2703.6 2706.1 2746.5 2593.9 2652.5 2676.4 2706.0 2728.6 2583.8 2605.8 2621.6 2642.2 2667.4 2606.4 2626.4 2627.0 2628.4 2630.2 13642.3 13790.2 13818.9 13832.2 13977.1 7313.0 7637.9 7654.2 7654.8 7660.5 4761.4 4885.7 4941.9 5061.6 5068.0 1741.0 1779.8 1788.6 1789.9 1806.1 22731.4 22837.7 22929.3 22931.2 23041.7 6130.4 6281.7 6429.4 6481.5 6487.0 15698.9 15758.2 15767.4 15769.4 15830.6 7163.8 7444.1 7468.1 7488.7 7533.5 5691.8 6032.3 6242.1 6260.2 7146.7 5045.1 5176.5 5180.6 5228.1 5289.7 1465.9 1506.3 1510.0 1524.9 1530.2 879.0 900.6 900.9 905.6 910.5 7148.3 7205.3 7225.0 7246.6 7294.5 700.9 712.6 720.0 737.2 750.7 4636.6 5385.4 5407.3 5424.4 5519.3 18968.2 19759.6 19781.0 19937.8 19974.3 19428.9 19835.8 19928.0 19938.2 20031.0 10042.6 10797.1 10829.8 10851.7 10892.2 8002.0 8074.5 8109.8 8129.2 8271.5 16671.3 16764.2 16812.7 17041.1 17630.0 17268.3 17332.9 17349.5 17443.3 17705.6 11561.4 11806.7 11817.4 11861.1 11881.8 13049.0 13257.4 13311.1 13312.5 13425.3 10749.4 10785.9 10824.7 11002.0 11062.6 9899.3 10604.4 10831.2 10881.1 11010.8 9753.0 9842.4 9936.9 9943.9 9948.7 7005.5 7042.8 7073.0 7156.5 7220.7 7540.8 7594.2 7608.9 7620.0 7689.1 17:25:28 INFO - PID 8284 | 17:25:28 INFO - PID 8284 | [#4] prototype.html Cycles:180 Average:5570.12 Median:6143.90 stddev:1559.57 (25.4%) stddev-sans-first:1516.76 17:25:28 INFO - PID 8284 | Values: 497.5 502.8 510.5 518.8 520.5 6250.0 6258.5 6301.0 6318.4 6341.5 6103.8 6156.4 6193.7 6222.3 6225.6 4922.1 5020.8 5049.6 5083.5 5084.9 4970.9 4980.1 5011.4 5018.7 5045.2 4991.3 4994.0 5005.5 5025.2 5027.3 5002.0 5020.3 5043.9 5052.7 5062.9 4519.7 4532.0 4539.5 4544.8 4569.6 6018.4 6076.2 6079.6 6103.7 6169.6 5742.8 5764.8 5769.7 5793.7 5800.3 6609.1 6654.7 6694.8 6702.5 6703.9 4884.8 4894.7 4916.5 4962.6 4984.1 6611.3 6756.7 6781.6 6930.5 6989.4 5008.0 5010.7 5020.2 5020.9 5034.3 5070.7 5086.8 5109.5 5131.3 5143.8 5739.2 5748.9 5764.2 5774.2 5784.7 6582.6 6642.7 6674.7 6688.7 6710.9 1789.0 1811.3 1816.6 1822.2 1825.1 1196.4 1229.3 1246.0 1253.7 1260.4 5730.5 5838.9 5860.6 5909.6 5934.3 6771.8 6795.5 6807.9 6884.3 6894.9 5737.9 5765.8 5809.3 5850.8 5870.2 3572.6 3610.1 3627.1 3664.9 3684.0 6478.4 6606.7 6624.4 6630.4 6679.4 6771.2 6811.8 6931.3 6965.8 6982.5 6131.4 6538.7 6581.3 6591.2 6623.5 6819.5 6854.3 6889.3 6921.0 6930.9 6721.6 6726.9 6737.9 6748.4 6847.9 6542.6 6605.8 6631.5 6637.7 6667.4 5023.0 5038.6 5059.7 5078.9 5104.1 6601.2 6665.4 6691.0 6849.9 6934.7 6578.5 6581.8 6614.2 6626.7 6644.2 6466.9 6514.4 6596.9 6627.5 6633.6 6489.2 6511.5 6550.6 6554.7 6584.7 6581.2 6617.0 6674.2 6709.6 6730.3 6456.6 6463.3 6471.7 6478.6 6533.0 17:25:28 INFO - PID 8284 | 17:25:28 INFO - PID 8284 | [#5] yui.html Cycles:180 Average:24103.11 Median:21919.45 stddev:31709.90 (144.7%) stddev-sans-first:31751.04 17:25:28 INFO - PID 8284 | Values: 912.0 913.8 930.0 935.6 939.0 19042.8 20006.6 20007.9 20011.9 22239.6 21950.2 21970.9 22213.2 22314.7 22404.9 968.7 986.0 989.7 991.0 991.7 975.9 1060.4 1060.4 1062.8 1063.2 1104.0 1118.7 1121.0 1121.2 1122.3 1099.3 1113.4 1113.6 1113.6 1116.3 797.9 801.2 807.8 808.2 808.6 20220.4 20475.6 20536.8 20574.1 20975.2 21780.9 21888.7 22174.2 22396.6 22399.4 16516.0 16587.2 16786.8 16944.5 17049.7 3649.7 3669.9 3672.4 3673.5 3673.6 122779.0 124437.0 126392.4 127162.0 127525.0 16896.8 17279.5 17330.2 17360.7 17717.6 31123.5 31694.5 31749.7 31847.0 32263.5 8004.4 8338.0 8347.6 8965.3 9092.5 4276.2 4456.4 4460.8 4465.3 4479.3 5248.2 5358.0 5406.8 5785.6 6016.1 1049.9 1052.5 1083.8 1088.3 1091.8 687.3 711.3 713.1 717.4 721.4 12123.5 12590.2 12697.7 13354.9 13371.9 610.5 635.2 667.6 724.5 737.1 5526.1 5830.7 5882.6 5932.8 6094.7 103114.0 103145.0 106686.5 106946.5 109674.5 94876.0 95137.5 96699.0 99532.5 100257.0 85157.0 85611.6 85983.1 88515.0 89346.0 10725.2 10736.0 10759.6 10800.6 11034.7 39160.0 39650.2 39824.8 39857.4 39927.4 69033.3 69413.3 69531.0 70395.0 71967.3 19223.8 19381.3 19580.8 19614.8 19627.1 22175.7 22759.2 22772.9 22920.8 23013.5 19435.0 19968.8 19995.4 20238.6 20245.5 20450.2 20668.7 20673.3 20735.7 20834.4 18225.5 18573.0 18649.3 19769.7 20102.6 12951.8 13306.8 14484.1 14640.6 14999.1 14577.5 14617.7 15208.2 15394.1 15536.8 17:25:28 INFO - PID 8284 | -------- Summary: end -------- 17:25:28 INFO - PID 8284 | 17:25:28 INFO - TEST-INFO | 8284: exit 0 17:25:28 INFO - TEST-OK | dromaeo_css | took 1111695ms 17:25:28 INFO - TEST-START | kraken 17:25:28 INFO - Initialising browser for kraken test... 17:25:28 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:47786/getInfo.html -profile /tmp/tmpbrwMst/profile 17:25:28 INFO - TEST-INFO | started process 8665 (/builds/slave/test/build/application/firefox/firefox http://localhost:47786/getInfo.html) 17:25:34 INFO - TEST-INFO | 8665: exit 0 17:25:34 INFO - Browser initialized. 17:25:34 INFO - Running cycle 1/1 for kraken test... 17:25:34 INFO - TEST-INFO | started process 8858 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbrwMst/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 17:25:35 INFO - PID 8858 | 17:25:35 INFO - PID 8858 | (/builds/slave/test/build/application/firefox/firefox:8911): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 17:25:35 INFO - PID 8858 | 17:25:45 INFO - PID 8858 | RSS: Main: 166240256 17:25:45 INFO - PID 8858 | 17:25:48 INFO - PID 8858 | Cycle 1(1): loaded http://localhost:47786/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:47786/tests/kraken/driver.html?testName=audio-beat-detection) 17:25:49 INFO - PID 8858 | RSS: Main: 172388352 17:25:49 INFO - PID 8858 | 17:25:51 INFO - PID 8858 | Cycle 1(1): loaded http://localhost:47786/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:47786/tests/kraken/driver.html?testName=audio-dft) 17:25:52 INFO - PID 8858 | RSS: Main: 176250880 17:25:52 INFO - PID 8858 | 17:25:55 INFO - PID 8858 | Cycle 1(1): loaded http://localhost:47786/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:47786/tests/kraken/driver.html?testName=audio-fft) 17:25:56 INFO - PID 8858 | RSS: Main: 170082304 17:25:56 INFO - PID 8858 | 17:25:58 INFO - PID 8858 | Cycle 1(1): loaded http://localhost:47786/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:47786/tests/kraken/driver.html?testName=audio-oscillator) 17:25:58 INFO - PID 8858 | RSS: Main: 170881024 17:25:58 INFO - PID 8858 | 17:26:01 INFO - PID 8858 | Cycle 1(1): loaded http://localhost:47786/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:47786/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:26:01 INFO - PID 8858 | RSS: Main: 171102208 17:26:01 INFO - PID 8858 | 17:26:04 INFO - PID 8858 | Cycle 1(1): loaded http://localhost:47786/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:47786/tests/kraken/driver.html?testName=imaging-darkroom) 17:26:05 INFO - PID 8858 | RSS: Main: 172400640 17:26:05 INFO - PID 8858 | 17:26:09 INFO - PID 8858 | Cycle 1(1): loaded http://localhost:47786/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:47786/tests/kraken/driver.html?testName=imaging-desaturate) 17:26:09 INFO - PID 8858 | RSS: Main: 172675072 17:26:09 INFO - PID 8858 | 17:26:12 INFO - PID 8858 | Cycle 1(1): loaded http://localhost:47786/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:47786/tests/kraken/driver.html?testName=json-parse-financial) 17:26:13 INFO - PID 8858 | RSS: Main: 172666880 17:26:13 INFO - PID 8858 | 17:26:14 INFO - PID 8858 | Cycle 1(1): loaded http://localhost:47786/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:47786/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:26:15 INFO - PID 8858 | RSS: Main: 172838912 17:26:15 INFO - PID 8858 | 17:26:17 INFO - PID 8858 | Cycle 1(1): loaded http://localhost:47786/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:47786/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:26:17 INFO - PID 8858 | RSS: Main: 173633536 17:26:17 INFO - PID 8858 | 17:26:20 INFO - PID 8858 | Cycle 1(1): loaded http://localhost:47786/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:47786/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:26:20 INFO - PID 8858 | RSS: Main: 172257280 17:26:20 INFO - PID 8858 | 17:26:23 INFO - PID 8858 | Cycle 1(1): loaded http://localhost:47786/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:47786/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:26:24 INFO - PID 8858 | RSS: Main: 173658112 17:26:24 INFO - PID 8858 | 17:26:27 INFO - PID 8858 | Cycle 1(1): loaded http://localhost:47786/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:47786/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:26:28 INFO - PID 8858 | RSS: Main: 173248512 17:26:28 INFO - PID 8858 | 17:26:29 INFO - PID 8858 | Cycle 1(1): loaded http://localhost:47786/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:47786/tests/kraken/driver.html?testName=ai-astar) 17:26:30 INFO - PID 8858 | RSS: Main: 175366144 17:26:30 INFO - PID 8858 | 17:26:30 INFO - PID 8858 | __start_tp_report 17:26:30 INFO - PID 8858 | _x_x_mozilla_page_load 17:26:30 INFO - PID 8858 | _x_x_mozilla_page_load_details 17:26:30 INFO - PID 8858 | |i|pagename|runs| 17:26:30 INFO - PID 8858 | |0;ai-astar;100;107;100;110;107;109;108;106;110;110 17:26:30 INFO - PID 8858 | |1;audio-beat-detection;141;121;144;167;128;146;145;117;180;121 17:26:30 INFO - PID 8858 | |2;audio-dft;163;162;163;162;163;171;169;168;164;166 17:26:30 INFO - PID 8858 | |3;audio-fft;77;77;75;166;75;75;74;74;152;76 17:26:30 INFO - PID 8858 | |4;audio-oscillator;79;78;128;82;78;78;132;80;79;123 17:26:30 INFO - PID 8858 | |5;imaging-gaussian-blur;115;114;115;120;114;114;114;115;114;114 17:26:30 INFO - PID 8858 | |6;imaging-darkroom;150;152;151;152;150;150;153;153;149;150 17:26:30 INFO - PID 8858 | |7;imaging-desaturate;100;94;94;94;94;94;94;94;94;97 17:26:30 INFO - PID 8858 | |8;json-parse-financial;54;53;53;54;53;60;58;57;55;53 17:26:30 INFO - PID 8858 | |9;json-stringify-tinderbox;56;56;55;55;55;55;58;57;55;55 17:26:30 INFO - PID 8858 | |10;stanford-crypto-aes;77;77;75;77;85;75;77;77;75;81 17:26:30 INFO - PID 8858 | |11;stanford-crypto-ccm;130;120;134;132;131;124;129;127;120;182 17:26:30 INFO - PID 8858 | |12;stanford-crypto-pbkdf2;193;180;176;181;177;176;175;180;175;181 17:26:30 INFO - PID 8858 | |13;stanford-crypto-sha256-iterative;71;73;72;70;67;70;74;72;69;67 17:26:30 INFO - PID 8858 | __end_tp_report 17:26:30 INFO - PID 8858 | __start_cc_report 17:26:30 INFO - PID 8858 | _x_x_mozilla_cycle_collect,962 17:26:30 INFO - PID 8858 | __end_cc_report 17:26:30 INFO - PID 8858 | __startTimestamp1503015990200__endTimestamp 17:26:30 INFO - PID 8858 | 17:26:30 INFO - PID 8858 | ------- Summary: start ------- 17:26:30 INFO - PID 8858 | Number of tests: 14 17:26:30 INFO - PID 8858 | 17:26:30 INFO - PID 8858 | [#0] ai-astar Cycles:10 Average:106.70 Median:108.50 stddev:3.80 (3.5%) stddev-sans-first:3.17 17:26:30 INFO - PID 8858 | Values: 100.0 107.0 100.0 110.0 107.0 109.0 108.0 106.0 110.0 110.0 17:26:30 INFO - PID 8858 | 17:26:30 INFO - PID 8858 | [#1] audio-beat-detection Cycles:10 Average:141.00 Median:144.50 stddev:20.53 (14.2%) stddev-sans-first:21.77 17:26:30 INFO - PID 8858 | Values: 141.0 121.0 144.0 167.0 128.0 146.0 145.0 117.0 180.0 121.0 17:26:30 INFO - PID 8858 | 17:26:30 INFO - PID 8858 | [#2] audio-dft Cycles:10 Average:165.10 Median:165.00 stddev:3.21 (1.9%) stddev-sans-first:3.32 17:26:30 INFO - PID 8858 | Values: 163.0 162.0 163.0 162.0 163.0 171.0 169.0 168.0 164.0 166.0 17:26:30 INFO - PID 8858 | 17:26:30 INFO - PID 8858 | [#3] audio-fft Cycles:10 Average:92.10 Median:75.00 stddev:35.43 (47.2%) stddev-sans-first:37.15 17:26:30 INFO - PID 8858 | Values: 77.0 77.0 75.0 166.0 75.0 75.0 74.0 74.0 152.0 76.0 17:26:30 INFO - PID 8858 | 17:26:30 INFO - PID 8858 | [#4] audio-oscillator Cycles:10 Average:93.70 Median:78.50 stddev:23.57 (30.0%) stddev-sans-first:24.39 17:26:30 INFO - PID 8858 | Values: 79.0 78.0 128.0 82.0 78.0 78.0 132.0 80.0 79.0 123.0 17:26:30 INFO - PID 8858 | 17:26:30 INFO - PID 8858 | [#5] imaging-gaussian-blur Cycles:10 Average:114.90 Median:114.50 stddev:1.85 (1.6%) stddev-sans-first:1.96 17:26:30 INFO - PID 8858 | Values: 115.0 114.0 115.0 120.0 114.0 114.0 114.0 115.0 114.0 114.0 17:26:30 INFO - PID 8858 | 17:26:30 INFO - PID 8858 | [#6] imaging-darkroom Cycles:10 Average:151.00 Median:151.50 stddev:1.41 (0.9%) stddev-sans-first:1.45 17:26:30 INFO - PID 8858 | Values: 150.0 152.0 151.0 152.0 150.0 150.0 153.0 153.0 149.0 150.0 17:26:30 INFO - PID 8858 | 17:26:30 INFO - PID 8858 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:94.00 stddev:2.02 (2.2%) stddev-sans-first:1.00 17:26:30 INFO - PID 8858 | Values: 100.0 94.0 94.0 94.0 94.0 94.0 94.0 94.0 94.0 97.0 17:26:30 INFO - PID 8858 | 17:26:30 INFO - PID 8858 | [#8] json-parse-financial Cycles:10 Average:55.00 Median:54.50 stddev:2.49 (4.6%) stddev-sans-first:2.62 17:26:30 INFO - PID 8858 | Values: 54.0 53.0 53.0 54.0 53.0 60.0 58.0 57.0 55.0 53.0 17:26:30 INFO - PID 8858 | 17:26:30 INFO - PID 8858 | [#9] json-stringify-tinderbox Cycles:10 Average:55.70 Median:55.50 stddev:1.06 (1.9%) stddev-sans-first:1.12 17:26:30 INFO - PID 8858 | Values: 56.0 56.0 55.0 55.0 55.0 55.0 58.0 57.0 55.0 55.0 17:26:30 INFO - PID 8858 | 17:26:30 INFO - PID 8858 | [#10] stanford-crypto-aes Cycles:10 Average:77.60 Median:77.00 stddev:3.13 (4.1%) stddev-sans-first:3.32 17:26:30 INFO - PID 8858 | Values: 77.0 77.0 75.0 77.0 85.0 75.0 77.0 77.0 75.0 81.0 17:26:30 INFO - PID 8858 | 17:26:30 INFO - PID 8858 | [#11] stanford-crypto-ccm Cycles:10 Average:132.90 Median:130.50 stddev:17.91 (13.7%) stddev-sans-first:18.97 17:26:30 INFO - PID 8858 | Values: 130.0 120.0 134.0 132.0 131.0 124.0 129.0 127.0 120.0 182.0 17:26:30 INFO - PID 8858 | 17:26:30 INFO - PID 8858 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:179.40 Median:180.00 stddev:5.36 (3.0%) stddev-sans-first:2.57 17:26:30 INFO - PID 8858 | Values: 193.0 180.0 176.0 181.0 177.0 176.0 175.0 180.0 175.0 181.0 17:26:30 INFO - PID 8858 | 17:26:30 INFO - PID 8858 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.50 Median:71.50 stddev:2.37 (3.3%) stddev-sans-first:2.51 17:26:30 INFO - PID 8858 | Values: 71.0 73.0 72.0 70.0 67.0 70.0 74.0 72.0 69.0 67.0 17:26:30 INFO - PID 8858 | -------- Summary: end -------- 17:26:30 INFO - PID 8858 | 17:26:30 INFO - PID 8858 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 17:26:30 INFO - TEST-INFO | 8858: exit 0 17:26:30 INFO - TEST-OK | kraken | took 62143ms 17:26:30 INFO - SUITE-END | took 1173s 17:26:31 INFO - Completed test suite (00:19:34) 17:26:31 INFO - javascript benchmark 17:26:31 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8562.040493154665, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3133.8119712817233, 3146.4493713600114, 3167.3190264093223, 3174.936501269974, 3206.983965080174, 6119.7246123924415, 6126.326104128542, 6180.072989051639, 6199.4110559496885, 6222.875542489148, 6131.754729810813, 6133.264008318997, 6160.907586386196, 6235.469985051276, 6273.278572964111, 5584.720763961806, 5613.354464236604, 5681.0, 5703.287089113861, 5740.196372507852, 5479.123340265558, 5552.472515111058, 5556.749946252408, 5699.2590963174725, 5715.514181294595, 5659.745311460994, 5719.742611582489, 5750.539956803466, 5751.942480575203, 5759.913601295942, 5662.263905692274, 5672.290963629546, 5725.312962444492, 5725.742341594639, 5761.337446193657, 5484.945150548523, 5551.0, 5583.274174357308, 5619.353774315924, 5644.915326270109, 6105.45050945417, 6167.660778657172, 6174.320824709278, 6194.845128871769, 6202.782902598433, 6640.667966601651, 6690.498212634023, 6705.128333316687, 6719.294474080249, 6730.360615741497, 6687.364700353459, 6692.63190524521, 6713.597184168965, 6805.421539169177, 6810.216825065131, 6087.817365479043, 6189.659568723719, 6258.968705156445, 6267.5299352548745, 6292.33930437302, 6781.966090169518, 6790.456763458911, 6792.76225332111, 6797.456203503708, 6814.0, 6358.109864618957, 6439.452646525004, 6445.742170313229, 6448.065030570541, 6453.128827608213, 6539.901901471481, 6544.934550654432, 6547.377999090078, 6550.148480697574, 6561.770338038241, 6509.707063182168, 6525.967370163119, 6546.639934803537, 6576.638284894377, 6578.440832529289, 6607.537472376887, 6675.499337549703, 6697.531172817856, 6701.530892837454, 6702.36327548882, 5380.435054319319, 5417.241586177938, 5463.098588732894, 5478.616496845262, 5486.753096110605, 4611.584957353787, 4629.25931850909, 4648.83729069481, 4656.068786242765, 4679.81280748773, 5779.942200578024, 5799.594028417971, 5809.24479817621, 5823.126531020296, 5824.126381042877, 6713.69788359525, 6777.220619628707, 6788.083608712761, 6800.557963732342, 6805.0, 5773.364929857712, 5796.739146738407, 5829.47534721877, 5849.561282903799, 5871.236739223874, 5790.826275211751, 5827.35899051104, 5860.208871802252, 5873.412658734178, 5959.880802383928, 6361.077643741632, 6361.968190159112, 6382.170317858741, 6391.42477177047, 6395.648239346788, 6511.47908167336, 6523.543351965317, 6546.639934803631, 6582.934170658232, 6600.339966003553, 6421.197350331208, 6436.420722135031, 6463.062855885964, 6497.415232629086, 6510.934890651033, 6548.148740663683, 6583.604983700993, 6645.069690243273, 6660.1341825564305, 6664.266930637723, 6545.181852268466, 6663.666816659051, 6679.933200668125, 6717.395434410926, 6813.216480104851, 6455.644939528371, 6462.095306656977, 6487.383698548819, 6492.805215843532, 6500.252470965899, 6442.291347951816, 6466.708998095191, 6468.15913931186, 6474.417302442803, 6484.773032944013, 5501.115271427173, 6379.93620063812, 6423.871522569429, 6494.707738151889, 6507.511936604868, 6521.087047813405, 6574.737010519526, 6585.506087043586, 6588.967055164693, 6664.50016248793, 6205.596636218631, 6290.0, 6348.619082855043, 6438.259600146043, 6447.387498187664], "value": 6063.369547140254, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [804.2600807257322, 827.5655280977489, 848.3552500099923, 871.9084496127911, 875.277895736018, 39430.40854387183, 40204.19591608166, 40218.79890600547, 40221.0, 40253.59746402535, 37096.81451592745, 37188.25623487528, 37381.62618373815, 37411.0, 37418.8129059355, 6647.933520664804, 6742.52802303839, 6758.1214442122455, 6779.559328643647, 6806.4554835613035, 6701.932980670204, 6784.72861085556, 6786.762463313785, 6798.52410331277, 6803.523753337268, 7437.888431673529, 7621.8475630487355, 7660.2722741339485, 7688.654010569509, 7692.384609231248, 7538.773836784905, 7619.0, 7630.198829122945, 7632.274933881273, 7651.693932242703, 7267.418606511466, 7474.85050298991, 7494.475386722932, 7516.473846830724, 7544.547327160388, 37313.25373492542, 37918.43122353167, 38032.0, 38053.619463805284, 38180.42729359062, 3478.286951175028, 3520.06718219672, 3543.4684797280356, 3556.6798988091195, 3557.1996300832366, 31025.534616980764, 31110.377792444026, 31134.688653113404, 31135.37729245425, 31222.843885780425, 4828.348172996635, 4868.05073010763, 4889.75551222441, 4890.144224760688, 4932.654714170009, 177989.1100544489, 180635.0, 188179.0, 189064.0, 208389.0, 50063.49936500661, 50313.49686503088, 50365.244521332206, 50410.49589504131, 50411.49588504068, 52398.21402678963, 52597.0, 52607.15874944435, 52711.472885271425, 52736.36318184152, 15703.371865125268, 15796.210189490479, 15805.0, 15812.525624231292, 16034.0, 13082.345882705828, 13092.934535327262, 13108.410121544553, 13171.078024538381, 13187.142835715647, 14351.641208969859, 14374.209418481874, 14390.06464579799, 14467.638309042359, 14526.128432294096, 5756.395578464201, 5892.734826932799, 5910.497607703307, 5956.761729530857, 6023.156758053876, 987.9456629885425, 999.7750506136061, 1005.7686732051523, 1021.5300961557618, 1026.625281772148, 22963.655545166836, 29000.27499312492, 29277.85361073181, 30164.54753178704, 30298.84850575733, 1083.6315652678127, 1085.7394225385851, 1087.7008822573698, 1091.2906610703108, 1096.4846522134585, 12278.0, 12695.04787140968, 12809.807852882213, 12884.549040783715, 12915.806262906064, 231961.0, 233959.0, 234042.0, 235005.0, 235598.0, 51539.48460515422, 51545.0, 51854.0, 51933.740331298104, 52095.73952130291, 1454.1057249791513, 1463.8902082343866, 1492.1047371577183, 1497.7907586310323, 1505.5784380373514, 22729.88635056814, 22848.31455056351, 22878.65682014738, 23123.88438057799, 23159.421014474774, 34487.65512344844, 34647.82676086603, 34666.48000280048, 34672.65327346795, 34698.65301347055, 196590.0, 197685.0, 197717.0, 197870.0, 198432.0, 34185.31629367349, 36612.26775464529, 37414.0, 37449.81275093607, 37577.81211093927, 46151.53848461472, 46199.53800461952, 46594.76702616465, 46742.76628616835, 47117.52882471131, 34621.65378346285, 34723.4791478123, 34808.82595587006, 34954.825225873705, 35495.0, 33727.49408758822, 33826.83086584551, 33985.0, 34073.65926340804, 34393.140171495914, 37045.0, 37132.81433592923, 37141.0, 37312.0, 37430.0, 32485.675143248263, 32545.186370339983, 32547.34905301928, 32594.83702581567, 32805.17987050343, 23887.402814929766, 24978.50042999166, 25339.55582561724, 25492.490150197264, 25611.615825762256], "value": 17215.022626585767, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [553.4410245651893, 567.1039757183651, 574.2247965246916, 577.3937365765945, 585.6866576381636, 21669.0, 22360.776392236072, 22382.104715811347, 22498.66252006217, 22984.19555315564, 26668.19995400141, 26948.056818011373, 26992.190234292953, 27011.594826077577, 27413.86293068537, 6387.744490220397, 6541.934580654204, 6542.901856472156, 6544.0, 6568.146141001687, 5882.588218824684, 6379.681015949184, 6395.61626302421, 6402.839929001766, 6473.093766872642, 6337.302896681362, 6341.04884267359, 6342.39747224013, 6361.68191590421, 6369.872602547946, 6302.306746257908, 6324.083007963843, 6331.873362532747, 6340.397662222082, 6342.682865856688, 5903.291605007426, 5919.437653422961, 5921.733521991478, 5929.229200203989, 5930.0808374701555, 28406.289842754097, 29246.70753292461, 29756.40487190244, 29919.850400748073, 30190.698093019008, 1911.9713204301947, 1947.5423275530238, 1949.6685563454105, 1950.044478205669, 1950.4928718533142, 19300.80699193004, 19880.0, 19900.20399184031, 19931.90034049835, 19946.80053199464, 2331.673565700786, 2350.7884290413945, 2383.1420688552107, 2424.4544977380124, 2425.514897020585, 144128.27935860358, 145345.0, 147520.0, 148149.0, 149116.0, 14586.635334116732, 15424.691506170038, 15526.534203973899, 15640.139792311533, 15758.68482630341, 23769.0, 23773.524529509312, 23800.285991420285, 23801.880990595284, 23818.52362952766, 10421.0, 10475.52860121281, 10533.84199237012, 10589.199836027894, 10745.892541074489, 8696.826063478695, 9754.024597540189, 9785.07041831025, 9810.75473113178, 9884.752881177885, 8257.339412846957, 9274.397164184307, 9400.48297343639, 9527.809023872016, 9611.375260608038, 2643.603459481055, 2676.7189445108374, 2751.9724802751716, 2847.25971247473, 2861.7996740227986, 979.7109852593502, 996.6163027234567, 1010.7169992402139, 1017.2929813779352, 1020.5764607687875, 20366.0, 20785.688214676793, 20795.896020519802, 20869.0, 20976.37070887876, 1054.6097943760703, 1057.370864335719, 1059.86751656043, 1070.5236169904474, 1088.8203446431407, 11242.831357529643, 11693.239939403911, 11707.360879673657, 11748.353840538852, 13680.384382702803, 512559.6676586287, 523488.0, 536526.0, 541136.0, 545941.0, 124403.0, 124728.37635811763, 125573.0, 126691.0, 127139.36430317789, 1271.3643178410794, 1271.5676669932268, 1309.4762095162012, 1318.45284207053, 1327.6548097494722, 21712.782872171076, 21775.346739597837, 21900.561988760455, 22031.33905982823, 22163.22428714987, 59073.11390329063, 59744.40255597388, 59781.0, 60125.69937150461, 61071.0, 75811.0, 76037.23962760523, 76063.0, 76139.0, 77548.61225693836, 14924.104553726811, 14953.102813831205, 15052.397904084151, 15086.17026063577, 15138.697226055638, 23743.643845341987, 23875.283741487783, 23902.0, 24061.639075414234, 24067.879660601586, 18631.72052419188, 18935.810641893404, 18999.33502327467, 19052.523686907385, 19081.141348639067, 16667.66664666724, 17088.316467341167, 17225.483235502954, 17431.389901353392, 17452.301907923542, 18871.622567548846, 19289.324873629357, 19324.0, 19356.90321548383, 19365.61268774645, 14212.857871421153, 14808.703825923205, 14824.7776283358, 14865.108093514424, 14872.702545949236, 18713.0, 19015.52461188481, 19054.42836714901, 19079.332223372116, 19130.330438434587], "value": 12325.537325231715, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1362.8977826663, 1411.0475429085366, 1418.1136789506554, 1425.6293363725442, 1438.9280535973205, 13588.592342229736, 13649.931750341259, 14215.289235538234, 14251.788597969173, 14274.857251427482, 14391.856081439182, 14590.927045364784, 14629.195394253311, 14651.780223296633, 14680.0, 2670.626112344273, 2734.398432344891, 2734.53512902806, 2736.192823117185, 2737.575675770249, 2648.9470210595778, 2702.162329677806, 2703.648525691657, 2706.134037108126, 2746.5468197747346, 2593.8962441502413, 2652.5225459417297, 2676.397810492643, 2706.0, 2728.590711393287, 2583.767460928516, 2605.7654811067, 2621.580547112472, 2642.2469596165192, 2667.413169102794, 2606.374470127175, 2626.4353164069626, 2627.0, 2628.3823301524126, 2630.224083895236, 13642.317884105754, 13790.172589644653, 13818.86181138196, 13832.170069795844, 13977.091489053179, 7313.0, 7637.885431718529, 7654.158042615308, 7654.808629784245, 7660.463767536275, 4761.381020467317, 4885.706857588556, 4941.876453088666, 5061.620378471593, 5067.974660126676, 1741.0, 1779.7686300780815, 1788.6243888783372, 1789.910504474771, 1806.0879255975779, 22731.431714207112, 22837.657435138488, 22929.31212063624, 22931.197408090637, 23041.654375184386, 6130.356312587203, 6281.748730050838, 6429.431665425734, 6481.546291759531, 6486.967565162144, 15698.9215053924, 15758.212089395485, 15767.369305227892, 15769.44806931752, 15830.60423489399, 7163.820904477326, 7444.106707195171, 7468.066491688539, 7488.700451981859, 7533.472656913963, 5691.8292451226525, 6032.306284777219, 6242.1261023455845, 6260.154879091356, 7146.678399472036, 5045.117104506697, 5176.50823171798, 5180.559652429511, 5228.137357335997, 5289.70906600133, 1465.8900582456358, 1506.284514855435, 1509.9698006039819, 1524.885633577486, 1530.1737061986403, 878.9560521973875, 900.6397441023512, 900.8513595256841, 905.6196397513061, 910.5083255042204, 7148.285171482914, 7205.279472052857, 7225.0, 7246.601436920914, 7294.513873967472, 700.8837659898364, 712.6080655639378, 719.9856002879914, 737.2038198745342, 750.7297372945735, 4636.5752070077415, 5385.434529374437, 5407.297051383373, 5424.376196737347, 5519.31008623922, 18968.24127034903, 19759.60480790376, 19781.0, 19937.800621993883, 19974.30089946845, 19428.902855485914, 19835.801641983395, 19928.0, 19938.20247190125, 20031.0, 10042.648507302209, 10797.136229101652, 10829.783404331869, 10851.67444976652, 10892.183086268562, 8001.951695535459, 8074.475159114639, 8109.837803243784, 8129.227723366271, 8271.54506502148, 16671.333146674, 16764.1617919106, 16812.747808782635, 17041.147942603067, 17630.0, 17268.30926762966, 17332.91333543324, 17349.479515614552, 17443.30226790914, 17705.557361066076, 11561.364124973206, 11806.704832379259, 11817.409129543661, 11861.05111591088, 11881.762364752483, 13049.0, 13257.403416846459, 13311.068225224528, 13312.46750129984, 13425.328733563087, 10749.355038697704, 10785.946070269598, 10824.67525974222, 11002.0, 11062.612808551663, 9899.307048506535, 10604.416757078434, 10831.18766092562, 10881.075108615856, 11010.834837477283, 9752.951235243778, 9842.409455432411, 9936.900630993598, 9943.900560994298, 9948.701538953843, 7005.54463959841, 7042.753503627348, 7073.0, 7156.534825236343, 7220.74727384539, 7540.773776786705, 7594.240575942362, 7608.885866712115, 7619.961900190464, 7689.077310722749], "value": 6334.035448961096, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [497.5074676070691, 502.84411832331966, 510.5150107397972, 518.7535920437792, 520.5211205690764, 6249.968750156254, 6258.5306102042305, 6300.968495157524, 6318.399752023556, 6341.524385671076, 6103.786367477139, 6156.41514056165, 6193.659348735818, 6222.253329600443, 6225.564210505267, 4922.138625740481, 5020.799168033274, 5049.596032317424, 5083.466236045218, 5084.949150508503, 4970.86252911248, 4980.128477516439, 5011.42368627607, 5018.673786203904, 5045.192769156935, 4991.326170966928, 4994.0, 5005.549500544968, 5025.170846810291, 5027.321311622939, 5002.0, 5020.314131939395, 5043.924341134886, 5052.696838189684, 5062.873428164288, 4519.661025423106, 4531.9803044315095, 4539.546045395434, 4544.818207271705, 4569.611583015414, 6018.368071352533, 6076.210092687967, 6079.574429789916, 6103.664298463583, 6169.598976066542, 5742.770289188427, 5764.769409223626, 5769.740361683735, 5793.681347525884, 5800.332961709415, 6609.109259148196, 6654.6672666366485, 6694.83262918426, 6702.497312701566, 6703.927371620517, 4884.804607815683, 4894.7063176209185, 4916.532929371704, 4962.635275299322, 4984.127777638899, 6611.272759996396, 6756.662166891636, 6781.62701051437, 6930.480213983921, 6989.3870045769545, 5008.0, 5010.674306170087, 5020.246962955513, 5020.899582008339, 5034.34553508049, 5070.670406423571, 5086.821961231413, 5109.489051094935, 5131.307273518102, 5143.8456846294675, 5739.196512488255, 5748.856278592985, 5764.204360884967, 5774.191613174159, 5784.652920824764, 6582.63795491243, 6642.671465706878, 6674.666266686743, 6688.699008544627, 6710.899336509956, 1788.9642207155784, 1811.2664370929795, 1816.6457540779686, 1822.1526989949737, 1825.1239405085632, 1196.4496331687521, 1229.305442425027, 1245.9813102803466, 1253.7053792358788, 1260.3950103950156, 5730.541556675456, 5838.9124163137585, 5860.633827798232, 5909.556783241274, 5934.258217722785, 6771.796846094625, 6795.524313298021, 6807.863842723118, 6884.277150899184, 6894.931050689429, 5737.876985515386, 5765.769369225268, 5809.331926828384, 5850.765969361178, 5870.236869206976, 3572.5891522474726, 3610.05057269077, 3627.093226693327, 3664.926701466009, 3683.963160368362, 6478.380404898775, 6606.711691220262, 6624.370684784938, 6630.370114839083, 6679.432248258855, 6771.239477735726, 6811.761588344483, 6931.306869313028, 6965.756198533027, 6982.47631427645, 6131.3897684051435, 6538.673066346759, 6581.301666316883, 6591.187423458491, 6623.503237257321, 6819.4656202356055, 6854.280300568568, 6889.345512176335, 6920.996455514023, 6930.861382772216, 6721.630310332978, 6726.939242644487, 6737.898931515933, 6748.392644662004, 6847.931520684929, 6542.640154791532, 6605.801825945229, 6631.469482441489, 6637.734490620514, 6667.43326817226, 5023.01590871611, 5038.622103342191, 5059.696418214919, 5078.898422031465, 5104.132297509506, 6601.207855057424, 6665.40011398957, 6690.951974055626, 6849.8972515411315, 6934.653267336512, 6578.506612004023, 6581.835454113685, 6614.173228346457, 6626.701798419179, 6644.202695676549, 6466.902996454963, 6514.413702766774, 6596.868062638624, 6627.502937279627, 6633.635150066792, 6489.1888513935755, 6511.544191906521, 6550.63971481554, 6554.673091052608, 6584.703688333941, 6581.157275962738, 6616.966915165393, 6674.16572928384, 6709.563878347892, 6730.32696730323, 6456.644884531208, 6463.289038205888, 6471.676416179078, 6478.643674597943, 6532.967335163484], "value": 5110.712843537253, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [911.9817603647928, 913.8218047480741, 930.0467021303159, 935.6351023100988, 939.0421769794807, 19042.809571904276, 20006.59986800263, 20007.899960500214, 20011.899940500294, 22239.555208895854, 21950.231741889038, 21970.89014554929, 22213.22253721116, 22314.665280020814, 22404.88797556014, 968.7093871838456, 985.9605615775396, 989.6635144051021, 991.013941128578, 991.6628346362236, 975.8877729061178, 1060.3690803971624, 1060.3849767135043, 1062.8405739139153, 1063.2291588598282, 1103.9944800275987, 1118.664400679797, 1120.966371008871, 1121.2375584602466, 1122.3490375582185, 1099.2964502718266, 1113.4432783608195, 1113.62136873463, 1113.6492005018392, 1116.2521110855664, 797.8603744344716, 801.1787917384727, 807.8182408957996, 808.1998821167002, 808.6361137488095, 20220.39338819838, 20475.5904881903, 20536.79463205379, 20574.074166662536, 20975.16099356024, 21780.89109554458, 21888.671669924963, 22174.223902163507, 22396.55206895853, 22399.440013999618, 16516.0, 16587.170641467877, 16786.83213167865, 16944.49166525006, 17049.65900681992, 3649.6897763690117, 3669.889903302905, 3672.4124140137715, 3673.4673472346362, 3673.5775385830702, 122779.0, 124437.0, 126392.36803816106, 127162.0, 127525.0, 16896.831031689773, 17279.481615551555, 17330.220140093727, 17360.65278694419, 17717.55706107332, 31123.533147002814, 31694.524582131286, 31749.682503175136, 31847.0, 32263.51604725931, 8004.399670024772, 8338.0, 8347.582620868932, 8965.327600429993, 9092.545372731469, 4276.18752437036, 4456.353828694886, 4460.799264033127, 4465.307877279027, 4479.260921947842, 5248.186531087687, 5358.035553600389, 5406.83779486616, 5785.623934444247, 6016.067509536029, 1049.8687664041995, 1052.5421441672897, 1083.7778255457613, 1088.3089238333714, 1091.781643671269, 687.29895506584, 711.3100292716057, 713.12642013533, 717.4153065251803, 721.4192574977194, 12123.515059397701, 12590.24458532491, 12697.746045079231, 13354.866451335361, 13371.866281337063, 610.5237914426755, 635.2028204603286, 667.6027763480721, 724.5399171526119, 737.0823324960459, 5526.143447765603, 5830.679312637845, 5882.55880808941, 5932.79235226765, 6094.725737341831, 103114.0, 103144.96855031504, 106686.46656766666, 106946.46526767472, 109674.45162774295, 94876.0, 95137.52431237938, 96699.0, 99532.50233748785, 100257.0, 85157.0, 85611.5719421399, 85983.14016859877, 88515.0, 89346.0, 10725.249232553646, 10736.033756961911, 10759.623413180501, 10800.567977281135, 11034.668959930894, 39160.0, 39650.20699585934, 39824.80087599543, 39857.40213896852, 39927.401088983104, 69033.3096669047, 69413.30586694069, 69531.0, 70395.0, 71967.28032719606, 19223.807761922202, 19381.321653742052, 19580.804191957897, 19614.803851961868, 19627.116779745233, 22175.667364989862, 22759.203427879944, 22772.886135569217, 22920.77079229253, 23013.53972920566, 19435.028248587798, 19968.800311996692, 19995.400137995883, 20238.595228095062, 20245.49386265355, 20450.181992720125, 20668.689969650168, 20673.276435324693, 20735.688964665846, 20834.374968750963, 18225.45323640293, 18573.0, 18649.254029839198, 19769.703454447907, 20102.597948040664, 12951.805722914352, 13306.800397993844, 14484.130952142905, 14640.633984150056, 14999.100053996795, 14577.489787857798, 14617.707645846811, 15208.163551004802, 15394.07635541871, 15536.84463155354], "value": 9459.038634360231, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1530.5, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 107.0, 100.0, 110.0, 107.0, 109.0, 108.0, 106.0, 110.0, 110.0], "value": 106.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 121.0, 144.0, 167.0, 128.0, 146.0, 145.0, 117.0, 180.0, 121.0], "value": 141.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 162.0, 163.0, 162.0, 163.0, 171.0, 169.0, 168.0, 164.0, 166.0], "value": 165.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 77.0, 75.0, 166.0, 75.0, 75.0, 74.0, 74.0, 152.0, 76.0], "value": 92.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 78.0, 128.0, 82.0, 78.0, 78.0, 132.0, 80.0, 79.0, 123.0], "value": 93.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 114.0, 115.0, 120.0, 114.0, 114.0, 114.0, 115.0, 114.0, 114.0], "value": 114.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 152.0, 151.0, 152.0, 150.0, 150.0, 153.0, 153.0, 149.0, 150.0], "value": 151.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 94.0, 94.0, 94.0, 94.0, 94.0, 94.0, 94.0, 94.0, 97.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 53.0, 53.0, 54.0, 53.0, 60.0, 58.0, 57.0, 55.0, 53.0], "value": 55.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 56.0, 55.0, 55.0, 55.0, 55.0, 58.0, 57.0, 55.0, 55.0], "value": 55.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 77.0, 75.0, 77.0, 85.0, 75.0, 77.0, 77.0, 75.0, 81.0], "value": 77.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [130.0, 120.0, 134.0, 132.0, 131.0, 124.0, 129.0, 127.0, 120.0, 182.0], "value": 132.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [193.0, 180.0, 176.0, 181.0, 177.0, 176.0, 175.0, 180.0, 175.0, 181.0], "value": 179.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 73.0, 72.0, 70.0, 67.0, 70.0, 74.0, 72.0, 69.0, 67.0], "value": 70.5, "unit": "score"}]}]} 17:26:31 INFO - Return code: 0 17:26:31 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 17:26:31 INFO - # TBPL SUCCESS # 17:26:31 INFO - Running post-action listener: _package_coverage_data 17:26:31 INFO - Running post-action listener: _resource_record_post_action 17:26:31 INFO - [mozharness: 2017-08-18 00:26:31.492220Z] Finished run-tests step (success) 17:26:31 INFO - Running post-run listener: _resource_record_post_run 17:26:31 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 4096; Write bytes: 434561024; Read time: 16; Write time: 273120 17:26:31 INFO - TinderboxPrint: CPU usage
13.1% 17:26:31 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 17:26:31 INFO - TinderboxPrint: I/O write bytes / time
434,561,024 / 273,120 17:26:31 INFO - TinderboxPrint: CPU idle
8,260.9 (86.8%) 17:26:31 INFO - TinderboxPrint: CPU user
1,201.2 (12.6%) 17:26:31 INFO - TinderboxPrint: Swap in / out
0 / 0 17:26:31 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 107773952; Read time: 0; Write time: 88924 17:26:31 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 17:26:31 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 0; Write bytes: 326787072; Read time: 0; Write time: 184196 17:26:32 INFO - Running post-run listener: _upload_blobber_files 17:26:32 INFO - Blob upload gear active. 17:26:32 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:26:32 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 17:26:32 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'] 17:26:32 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 17:26:32 INFO - (blobuploader) - INFO - Open directory for files ... 17:26:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 17:26:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:26:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:26:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 17:26:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:26:33 INFO - (blobuploader) - INFO - Done attempting. 17:26:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 17:26:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:26:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:26:40 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 17:26:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:26:40 INFO - (blobuploader) - INFO - Done attempting. 17:26:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 17:26:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:26:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:26:40 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 17:26:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:26:40 INFO - (blobuploader) - INFO - Done attempting. 17:26:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 17:26:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:26:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:26:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 17:26:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:26:41 INFO - (blobuploader) - INFO - Done attempting. 17:26:41 INFO - (blobuploader) - INFO - Iteration through files over. 17:26:41 INFO - Return code: 0 17:26:41 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:26:41 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:26:41 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/966f9317d60d0b4786d178573263dc76a6056fdabe50cc75870e1c9a3fb61c83ae5f23c4ae93d564d96ecaa7675be8a8045ced96a5ad683af60a05894656f073", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5706dfb1d458f3c5adec06bd4a639e0504c8364b49c634a8f1177d1c9dd076f2e9a6bfc1420f01e5a280b566e95c9cb2f2375e99ad692326d9872cdf85f36ace", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2ac2aa684ee082b6322a868af21f05496a867630d4203f318931e02f5dfbfef485e3a4eea31e27f3eee2ef90a9cca6318022cf7d7eadd9de7920f3f63f762356", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/680faed15ebef492a380ea53be425bdc6f2f7b37d0277d634220445eb05ce244bb2434d9223bced4220a420166bba8d17bba85acde826da1f28e3259c2e9ab7a"} 17:26:41 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:26:41 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:26:41 INFO - Contents: 17:26:41 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/966f9317d60d0b4786d178573263dc76a6056fdabe50cc75870e1c9a3fb61c83ae5f23c4ae93d564d96ecaa7675be8a8045ced96a5ad683af60a05894656f073", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5706dfb1d458f3c5adec06bd4a639e0504c8364b49c634a8f1177d1c9dd076f2e9a6bfc1420f01e5a280b566e95c9cb2f2375e99ad692326d9872cdf85f36ace", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2ac2aa684ee082b6322a868af21f05496a867630d4203f318931e02f5dfbfef485e3a4eea31e27f3eee2ef90a9cca6318022cf7d7eadd9de7920f3f63f762356", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/680faed15ebef492a380ea53be425bdc6f2f7b37d0277d634220445eb05ce244bb2434d9223bced4220a420166bba8d17bba85acde826da1f28e3259c2e9ab7a"} 17:26:41 INFO - Running post-run listener: copy_logs_to_upload_dir 17:26:41 INFO - Copying logs to upload dir... 17:26:41 INFO - mkdir: /builds/slave/test/build/upload/logs 17:26:41 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1253.719275 ========= master_lag: 0.06 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2017-08-17 17:26:41.532238) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-17 17:26:41.536499) ========= 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=20e666a3d4cfbb71505a330e000001b4-1503014745.989892-372896200 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/966f9317d60d0b4786d178573263dc76a6056fdabe50cc75870e1c9a3fb61c83ae5f23c4ae93d564d96ecaa7675be8a8045ced96a5ad683af60a05894656f073", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5706dfb1d458f3c5adec06bd4a639e0504c8364b49c634a8f1177d1c9dd076f2e9a6bfc1420f01e5a280b566e95c9cb2f2375e99ad692326d9872cdf85f36ace", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2ac2aa684ee082b6322a868af21f05496a867630d4203f318931e02f5dfbfef485e3a4eea31e27f3eee2ef90a9cca6318022cf7d7eadd9de7920f3f63f762356", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/680faed15ebef492a380ea53be425bdc6f2f7b37d0277d634220445eb05ce244bb2434d9223bced4220a420166bba8d17bba85acde826da1f28e3259c2e9ab7a"} build_url:https://queue.taskcluster.net/v1/task/b0RIcHGxQVmCDF_P3NNDKg/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011415 build_url: 'https://queue.taskcluster.net/v1/task/b0RIcHGxQVmCDF_P3NNDKg/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/966f9317d60d0b4786d178573263dc76a6056fdabe50cc75870e1c9a3fb61c83ae5f23c4ae93d564d96ecaa7675be8a8045ced96a5ad683af60a05894656f073", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5706dfb1d458f3c5adec06bd4a639e0504c8364b49c634a8f1177d1c9dd076f2e9a6bfc1420f01e5a280b566e95c9cb2f2375e99ad692326d9872cdf85f36ace", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2ac2aa684ee082b6322a868af21f05496a867630d4203f318931e02f5dfbfef485e3a4eea31e27f3eee2ef90a9cca6318022cf7d7eadd9de7920f3f63f762356", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/680faed15ebef492a380ea53be425bdc6f2f7b37d0277d634220445eb05ce244bb2434d9223bced4220a420166bba8d17bba85acde826da1f28e3259c2e9ab7a"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-17 17:26:41.565840) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-17 17:26:41.566230) ========= 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=20e666a3d4cfbb71505a330e000001b4-1503014745.989892-372896200 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004466 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-17 17:26:41.651048) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-17 17:26:41.651379) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-17 17:26:41.651678) ========= ========= Total master_lag: 0.23 =========