builder: mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s slave: talos-linux64-ix-044 starttime: 1503014752.11 results: success (0) revision: a6a1f5c1d971dbee67ba6eec7ead7902351ddca2 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-08-17 17:05:52.112427) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-08-17 17:05:52.112826) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-17 17:05:52.113089) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-17 17:05:52.128762) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-17 17:05:52.129015) ========= 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=88e9d754c8c9af9f7805d7f3000001bd-1503014751.369548-710723835 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-08-17 17:05:52-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 54.3M=0s 2017-08-17 17:05:52 (54.3 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.164533 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-17 17:05:52.308639) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-17 17:05:52.308942) ========= 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=88e9d754c8c9af9f7805d7f3000001bd-1503014751.369548-710723835 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.023356 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-17 17:05:52.358991) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-17 17:05:52.361327) ========= 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=88e9d754c8c9af9f7805d7f3000001bd-1503014751.369548-710723835 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-08-17 17:05:52,543 truncating revision to first 12 chars 2017-08-17 17:05:52,543 Setting DEBUG logging. 2017-08-17 17:05:52,543 attempt 1/10 2017-08-17 17:05:52,543 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:53,132 unpacking tar archive at: mozilla-central-a6a1f5c1d971/testing/mozharness/ program finished with exit code 0 elapsedTime=0.938113 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-17 17:05:53.313893) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-17 17:05:53.314233) ========= script_repo_revision: a6a1f5c1d971dbee67ba6eec7ead7902351ddca2 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-17 17:05:53.314618) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-17 17:05:53.314874) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-17 17:05:53.330492) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2017-08-17 17:05:53.330776) ========= /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=88e9d754c8c9af9f7805d7f3000001bd-1503014751.369548-710723835 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:05:53 INFO - MultiFileLogger online at 20170817 17:05:53 in /builds/slave/test 17:05:53 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:53 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:05:53 INFO - {'append_to_log': False, 17:05:53 INFO - 'base_work_dir': '/builds/slave/test', 17:05:53 INFO - 'blob_upload_branch': 'Firefox', 17:05:53 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:05:53 INFO - 'branch': 'Firefox', 17:05:53 INFO - 'buildbot_json_path': 'buildprops.json', 17:05:53 INFO - 'code_coverage': False, 17:05:53 INFO - 'config_files': ('talos/linux_config.py',), 17:05:53 INFO - 'default_actions': ('clobber', 17:05:53 INFO - 'read-buildbot-config', 17:05:53 INFO - 'download-and-extract', 17:05:53 INFO - 'populate-webroot', 17:05:53 INFO - 'create-virtualenv', 17:05:53 INFO - 'install', 17:05:53 INFO - 'setup-mitmproxy', 17:05:53 INFO - 'run-tests'), 17:05:53 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:05:53 INFO - 'disable_ccov_upload': False, 17:05:53 INFO - 'download_minidump_stackwalk': True, 17:05:53 INFO - 'download_symbols': 'ondemand', 17:05:53 INFO - 'enable_stylo': False, 17:05:53 INFO - 'enable_webrender': False, 17:05:53 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:05:53 INFO - 'tooltool.py': '/tools/tooltool.py', 17:05:53 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:05:53 INFO - '/tools/misc-python/virtualenv.py')}, 17:05:53 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:05:53 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:05:53 INFO - 'gecko_profile': False, 17:05:53 INFO - 'gecko_profile_interval': 0, 17:05:53 INFO - 'installer_path': 'installer.exe', 17:05:53 INFO - 'log_level': 'info', 17:05:53 INFO - 'log_name': 'talos', 17:05:53 INFO - 'log_to_console': True, 17:05:53 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:05:53 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:05:53 INFO - 'opt_config_files': (), 17:05:53 INFO - 'pip_index': False, 17:05:53 INFO - 'suite': 'dromaeojs-e10s', 17:05:53 INFO - 'system_bits': '32', 17:05:53 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:05:53 INFO - 'title': 'talos-linux64-ix-044', 17:05:53 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:05:53 INFO - 'use_talos_json': True, 17:05:53 INFO - 'verify': 'False', 17:05:53 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:05:53 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:05:53 INFO - 'work_dir': 'build'} 17:05:53 INFO - [mozharness: 2017-08-18 00:05:53.652187Z] Running clobber step. 17:05:53 INFO - Running pre-action listener: _resource_record_pre_action 17:05:53 INFO - Running main action method: clobber 17:05:53 INFO - rmtree: /builds/slave/test/build 17:05:53 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:05:54 INFO - Running post-action listener: _resource_record_post_action 17:05:54 INFO - [mozharness: 2017-08-18 00:05:54.667768Z] Finished clobber step (success) 17:05:54 INFO - [mozharness: 2017-08-18 00:05:54.667867Z] Running read-buildbot-config step. 17:05:54 INFO - Running pre-action listener: _resource_record_pre_action 17:05:54 INFO - Running main action method: read_buildbot_config 17:05:54 INFO - Using buildbot properties: 17:05:54 INFO - { 17:05:54 INFO - "project": "", 17:05:54 INFO - "product": "firefox", 17:05:54 INFO - "who": "kwierso@gmail.com", 17:05:54 INFO - "installer_path": "public/build/target.tar.bz2", 17:05:54 INFO - "builddir": "mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s", 17:05:54 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 17:05:54 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo mozilla-central talos dromaeojs-e10s", 17:05:54 INFO - "stage_platform": "linux64-stylo", 17:05:54 INFO - "basedir": "/builds/slave/test", 17:05:54 INFO - "buildnumber": 41, 17:05:54 INFO - "platform": "ubuntu64_hw_stylo", 17:05:54 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 17:05:54 INFO - "slavebuilddir": "test", 17:05:54 INFO - "taskId": "Kc-TZT0RR6SFf7tdAV17og", 17:05:54 INFO - "branch": "mozilla-central", 17:05:54 INFO - "script_repo_revision": "production", 17:05:54 INFO - "revision": "a6a1f5c1d971dbee67ba6eec7ead7902351ddca2", 17:05:54 INFO - "slavename": "talos-linux64-ix-044", 17:05:54 INFO - "repo_path": "mozilla-central" 17:05:54 INFO - } 17:05:54 INFO - Finding installer, test and symbols from parent task. 17:05:54 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Kc-TZT0RR6SFf7tdAV17og'}, attempt #1 17:05:55 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Kc-TZT0RR6SFf7tdAV17og'}, attempt #1 17:05:55 INFO - Task dependencies: b0RIcHGxQVmCDF_P3NNDKg 17:05:55 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/b0RIcHGxQVmCDF_P3NNDKg'}, attempt #1 17:05:56 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/b0RIcHGxQVmCDF_P3NNDKg/artifacts/public/build/target.tar.bz2 17:05:56 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/b0RIcHGxQVmCDF_P3NNDKg/artifacts/public/build/target.test_packages.json 17:05:56 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/b0RIcHGxQVmCDF_P3NNDKg/artifacts/public/build/target.crashreporter-symbols.zip 17:05:56 INFO - Running post-action listener: _resource_record_post_action 17:05:56 INFO - [mozharness: 2017-08-18 00:05:56.083590Z] Finished read-buildbot-config step (success) 17:05:56 INFO - [mozharness: 2017-08-18 00:05:56.083809Z] Running download-and-extract step. 17:05:56 INFO - Running pre-action listener: _resource_record_pre_action 17:05:56 INFO - Running main action method: download_and_extract 17:05:56 INFO - mkdir: /builds/slave/test/build/tests 17:05: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:05:56 INFO - trying https://queue.taskcluster.net/v1/task/b0RIcHGxQVmCDF_P3NNDKg/artifacts/public/build/target.test_packages.json 17:05:56 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:56 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:56 INFO - Downloaded 989 bytes. 17:05:56 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 17:05:56 INFO - Using the following test package requirements: 17:05:56 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 17:05:56 INFO - u'common': [u'target.common.tests.zip'], 17:05:56 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 17:05:56 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 17:05:56 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 17:05:56 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 17:05:56 INFO - u'mozbase': [u'target.common.tests.zip'], 17:05:56 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 17:05:56 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 17:05:56 INFO - u'web-platform': [u'target.common.tests.zip', 17:05:56 INFO - u'target.web-platform.tests.tar.gz'], 17:05:56 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 17:05:56 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 17:05:56 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:56 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:56 INFO - Fetch https://queue.taskcluster.net/v1/task/b0RIcHGxQVmCDF_P3NNDKg/artifacts/public/build/target.common.tests.zip into memory 17:05:57 INFO - Content-Length response header: 54002001 17:05:57 INFO - Bytes received: 54002001 17:06:08 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 17:06:08 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:08 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:08 INFO - Fetch https://queue.taskcluster.net/v1/task/b0RIcHGxQVmCDF_P3NNDKg/artifacts/public/build/target.common.tests.zip into memory 17:06:09 INFO - Content-Length response header: 54002001 17:06:09 INFO - Bytes received: 54002001 17:06:21 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:21 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:21 INFO - Fetch https://queue.taskcluster.net/v1/task/b0RIcHGxQVmCDF_P3NNDKg/artifacts/public/build/target.talos.tests.zip into memory 17:06:22 INFO - Content-Length response header: 14496161 17:06:22 INFO - Bytes received: 14496161 17:06:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:06:22 INFO - trying https://queue.taskcluster.net/v1/task/b0RIcHGxQVmCDF_P3NNDKg/artifacts/public/build/target.tar.bz2 17:06:22 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:22 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:24 INFO - Downloaded 62316180 bytes. 17:06:24 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/b0RIcHGxQVmCDF_P3NNDKg/artifacts/public/build/target.tar.bz2 17:06:24 INFO - mkdir: /builds/slave/test/properties 17:06:24 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:06:24 INFO - Writing to file /builds/slave/test/properties/build_url 17:06:24 INFO - Contents: 17:06:24 INFO - build_url:https://queue.taskcluster.net/v1/task/b0RIcHGxQVmCDF_P3NNDKg/artifacts/public/build/target.tar.bz2 17:06:24 INFO - Running post-action listener: _resource_record_post_action 17:06:24 INFO - Running post-action listener: find_tests_for_verification 17:06:24 INFO - Running post-action listener: set_extra_try_arguments 17:06:24 INFO - [mozharness: 2017-08-18 00:06:24.005575Z] Finished download-and-extract step (success) 17:06:24 INFO - [mozharness: 2017-08-18 00:06:24.005670Z] Running populate-webroot step. 17:06:24 INFO - Running pre-action listener: _resource_record_pre_action 17:06:24 INFO - Running main action method: populate_webroot 17:06:24 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:06:24 INFO - 'chromez-stylo-e10s': {'talos_options': ['--stylo'], 17:06:24 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:06:24 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:06:24 INFO - 'dromaeojs-stylo-e10s': {'talos_options': ['--stylo'], 17:06:24 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:06:24 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 17:06:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:06:24 INFO - 'g1-stylo-e10s': {'pagesets_name': 'tp5n.zip', 17:06:24 INFO - 'talos_options': ['--stylo'], 17:06:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:06:24 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 17:06:24 INFO - 'tests': ['damp', 'tps']}, 17:06:24 INFO - 'g2-stylo-e10s': {'pagesets_name': 'tp5n.zip', 17:06:24 INFO - 'talos_options': ['--stylo'], 17:06:24 INFO - 'tests': ['damp', 'tps']}, 17:06:24 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:06:24 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 17:06:24 INFO - 'g4-stylo-e10s': {'talos_options': ['--stylo'], 17:06:24 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 17:06:24 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 17:06:24 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 17:06:24 INFO - 'g5-stylo-e10s': {'pagesets_name': 'tp5n.zip', 17:06:24 INFO - 'talos_options': ['--stylo'], 17:06:24 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 17:06:24 INFO - 'other-e10s': {'tests': ['a11yr', 17:06:24 INFO - 'ts_paint', 17:06:24 INFO - 'tpaint', 17:06:24 INFO - 'sessionrestore', 17:06:24 INFO - 'sessionrestore_many_windows', 17:06:24 INFO - 'sessionrestore_no_auto_restore', 17:06:24 INFO - 'tabpaint']}, 17:06:24 INFO - 'other-stylo-e10s': {'talos_options': ['--stylo'], 17:06:24 INFO - 'tests': ['a11yr', 17:06:24 INFO - 'ts_paint', 17:06:24 INFO - 'tpaint', 17:06:24 INFO - 'sessionrestore', 17:06:24 INFO - 'sessionrestore_many_windows', 17:06:24 INFO - 'sessionrestore_no_auto_restore', 17:06:24 INFO - 'tabpaint']}, 17:06:24 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 17:06:24 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 17:06:24 INFO - 'perf-reftest-singletons-stylo-e10s': {'talos_options': ['--stylo'], 17:06:24 INFO - 'tests': ['bloom_basic_singleton']}, 17:06:24 INFO - 'perf-reftest-stylo-e10s': {'talos_options': ['--stylo'], 17:06:24 INFO - 'tests': ['bloom_basic']}, 17:06:24 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:06:24 INFO - 'tsvgr_opacity', 17:06:24 INFO - 'tart', 17:06:24 INFO - 'tscrollx', 17:06:24 INFO - 'tsvg_static']}, 17:06:24 INFO - 'svgr-stylo-e10s': {'talos_options': ['--stylo'], 17:06:24 INFO - 'tests': ['tsvgx', 17:06:24 INFO - 'tsvgr_opacity', 17:06:24 INFO - 'tart', 17:06:24 INFO - 'tscrollx', 17:06:24 INFO - 'tsvg_static']}, 17:06:24 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 17:06:24 INFO - 'tp5o-stylo-e10s': {'pagesets_name': 'tp5n.zip', 17:06:24 INFO - 'talos_options': ['--stylo'], 17:06:24 INFO - 'tests': ['tp5o']}, 17:06:24 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 17:06:24 INFO - 'talos_options': ['--mitmproxy', 17:06:24 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 17:06:24 INFO - '--firstNonBlankPaint'], 17:06:24 INFO - 'tests': ['tp6_google', 17:06:24 INFO - 'tp6_youtube', 17:06:24 INFO - 'tp6_amazon', 17:06:24 INFO - 'tp6_facebook']}, 17:06:24 INFO - 'tp6-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 17:06:24 INFO - 'talos_options': ['--stylo', 17:06:24 INFO - '--mitmproxy', 17:06:24 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 17:06:24 INFO - '--firstNonBlankPaint'], 17:06:24 INFO - 'tests': ['tp6_google', 17:06:24 INFO - 'tp6_youtube', 17:06:24 INFO - 'tp6_amazon', 17:06:24 INFO - 'tp6_facebook']}, 17:06:24 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 17:06:24 INFO - 'talos_options': ['--stylo', 17:06:24 INFO - '--stylo-threads=1', 17:06:24 INFO - '--mitmproxy', 17:06:24 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 17:06:24 INFO - '--firstNonBlankPaint'], 17:06:24 INFO - 'tests': ['tp6_google', 17:06:24 INFO - 'tp6_youtube', 17:06:24 INFO - 'tp6_amazon', 17:06:24 INFO - 'tp6_facebook']}, 17:06:24 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 17:06:24 INFO - 'talos_options': ['--xperf_path', 17:06:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:06:24 INFO - 'tests': ['tp5n']}, 17:06:24 INFO - 'xperf-stylo-e10s': {'pagesets_name': 'tp5n.zip', 17:06:24 INFO - 'talos_options': ['--stylo', 17:06:24 INFO - '--xperf_path', 17:06:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:06:24 INFO - 'tests': ['tp5n']}}} 17:06:24 INFO - Running post-action listener: _resource_record_post_action 17:06:24 INFO - [mozharness: 2017-08-18 00:06:24.019899Z] Finished populate-webroot step (success) 17:06:24 INFO - [mozharness: 2017-08-18 00:06:24.019989Z] Running create-virtualenv step. 17:06:24 INFO - Running pre-action listener: _resource_record_pre_action 17:06:24 INFO - Running main action method: create_virtualenv 17:06:24 INFO - Creating virtualenv /builds/slave/test/build/venv 17:06:24 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:24 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:06:24 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 17:06:24 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:06:24 INFO - Using real prefix '/usr' 17:06:24 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:06:24 INFO - Installing distribute.............................................................................................................................................................................................done. 17:06:26 INFO - Installing pip.................done. 17:06:26 INFO - Return code: 0 17:06:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 17:06:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 17:06:26 INFO - Reading from file tmpfile_stdout 17:06:26 INFO - Output received: 17:06:26 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:26 INFO - Installing pip>=1.5 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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a4e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b52a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cf5ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cf30b0>, '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 0x2cf3fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cf4440>, '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': '88e9d754c8c9af9f7805d7f3000001bd-1503014751.369548-710723835', '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', 'pip>=1.5'] 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 pip>=1.5 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': '88e9d754c8c9af9f7805d7f3000001bd-1503014751.369548-710723835', 17:06:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:06:26 INFO - '_': '/tools/buildbot/bin/python'} 17:06:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:06:27 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:27 INFO - Cleaning up... 17:06:27 INFO - Return code: 0 17:06:27 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 17:06:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:06:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:06:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:06:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:06:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x2a4e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b52a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cf5ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cf30b0>, '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 0x2cf3fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cf4440>, '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': '88e9d754c8c9af9f7805d7f3000001bd-1503014751.369548-710723835', '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:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 17:06:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 17:06:27 INFO - Using env: {'DISPLAY': ':0', 17:06:27 INFO - 'HOME': '/home/cltbld', 17:06:27 INFO - 'LANG': 'en_US.UTF-8', 17:06:27 INFO - 'LANGUAGE': 'en_US:en', 17:06:27 INFO - 'LOGNAME': 'cltbld', 17:06:27 INFO - 'MAIL': '/var/mail/cltbld', 17:06:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:06:27 INFO - 'MOZ_NO_REMOTE': '1', 17:06:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:06:27 INFO - 'NO_EM_RESTART': '1', 17:06:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:06:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:06:27 INFO - 'PWD': '/builds/slave/test', 17:06:27 INFO - 'SHELL': '/bin/bash', 17:06:27 INFO - 'SHLVL': '1', 17:06:27 INFO - 'TERM': 'linux', 17:06:27 INFO - 'TMOUT': '86400', 17:06:27 INFO - 'USER': 'cltbld', 17:06:27 INFO - 'XDG_SESSION_COOKIE': '88e9d754c8c9af9f7805d7f3000001bd-1503014751.369548-710723835', 17:06:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:06:27 INFO - '_': '/tools/buildbot/bin/python'} 17:06:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:06:27 INFO - Downloading/unpacking psutil>=3.1.1 17:06:27 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:27 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 - 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:27 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/psutil/setup.py) egg_info for package psutil 17:06:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:06:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:06:28 INFO - Installing collected packages: psutil 17:06:28 INFO - Running setup.py install for psutil 17:06:28 INFO - building 'psutil._psutil_linux' extension 17:06:28 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:28 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:28 INFO - building 'psutil._psutil_posix' extension 17:06:28 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:28 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:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:06:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:06:28 INFO - Successfully installed psutil 17:06:28 INFO - Cleaning up... 17:06:29 INFO - Return code: 0 17:06:29 INFO - Installing mozsystemmonitor==0.3 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', '--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 0x2a4e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b52a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cf5ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cf30b0>, '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 0x2cf3fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cf4440>, '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': '88e9d754c8c9af9f7805d7f3000001bd-1503014751.369548-710723835', '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', '--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:29 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: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': '88e9d754c8c9af9f7805d7f3000001bd-1503014751.369548-710723835', 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 - Downloading/unpacking mozsystemmonitor==0.3 17:06:29 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:29 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:29 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:29 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:30 INFO - Downloading mozsystemmonitor-0.3.tar.gz 17:06:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:06:30 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:30 INFO - Installing collected packages: mozsystemmonitor 17:06:30 INFO - Running setup.py install for mozsystemmonitor 17:06:30 INFO - Successfully installed mozsystemmonitor 17:06:30 INFO - Cleaning up... 17:06:30 INFO - Return code: 0 17:06:30 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 17:06:30 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:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:06:30 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:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:06:30 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 0x2a4e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b52a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cf5ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cf30b0>, '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 0x2cf3fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cf4440>, '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': '88e9d754c8c9af9f7805d7f3000001bd-1503014751.369548-710723835', '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:30 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:30 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:30 INFO - Using env: {'DISPLAY': ':0', 17:06:30 INFO - 'HOME': '/home/cltbld', 17:06:30 INFO - 'LANG': 'en_US.UTF-8', 17:06:30 INFO - 'LANGUAGE': 'en_US:en', 17:06:30 INFO - 'LOGNAME': 'cltbld', 17:06:30 INFO - 'MAIL': '/var/mail/cltbld', 17:06:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:06:30 INFO - 'MOZ_NO_REMOTE': '1', 17:06:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:06:30 INFO - 'NO_EM_RESTART': '1', 17:06:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:06:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:06:30 INFO - 'PWD': '/builds/slave/test', 17:06:30 INFO - 'SHELL': '/bin/bash', 17:06:30 INFO - 'SHLVL': '1', 17:06:30 INFO - 'TERM': 'linux', 17:06:30 INFO - 'TMOUT': '86400', 17:06:30 INFO - 'USER': 'cltbld', 17:06:30 INFO - 'XDG_SESSION_COOKIE': '88e9d754c8c9af9f7805d7f3000001bd-1503014751.369548-710723835', 17:06:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:06:30 INFO - '_': '/tools/buildbot/bin/python'} 17:06:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:06:30 INFO - Downloading/unpacking jsonschema==2.5.1 17:06:30 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:30 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:30 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:30 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:31 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:06:31 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 17:06:31 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:31 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:31 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:31 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:31 INFO - Downloading functools32-3.2.3-2.tar.gz 17:06:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:06:31 INFO - warning: no files found matching '*.txt' 17:06:31 INFO - no previously-included directories found matching 'build' 17:06:31 INFO - no previously-included directories found matching 'dist' 17:06:32 INFO - no previously-included directories found matching '.git*' 17:06:32 INFO - Installing collected packages: jsonschema, functools32 17:06:32 INFO - Running setup.py install for functools32 17:06:32 INFO - warning: no files found matching '*.txt' 17:06:32 INFO - no previously-included directories found matching 'build' 17:06:32 INFO - no previously-included directories found matching 'dist' 17:06:32 INFO - no previously-included directories found matching '.git*' 17:06:32 INFO - Successfully installed jsonschema functools32 17:06:32 INFO - Cleaning up... 17:06:32 INFO - Return code: 0 17:06:32 INFO - Installing functools32==3.2.3-2 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', '--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 0x2a4e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b52a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cf5ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cf30b0>, '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 0x2cf3fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cf4440>, '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': '88e9d754c8c9af9f7805d7f3000001bd-1503014751.369548-710723835', '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', '--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:32 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: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': '88e9d754c8c9af9f7805d7f3000001bd-1503014751.369548-710723835', 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 - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 17:06:32 INFO - Cleaning up... 17:06:32 INFO - Return code: 0 17:06:32 INFO - Installing blobuploader==1.2.4 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', '--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 0x2a4e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b52a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cf5ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cf30b0>, '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 0x2cf3fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cf4440>, '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': '88e9d754c8c9af9f7805d7f3000001bd-1503014751.369548-710723835', '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', '--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:32 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: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': '88e9d754c8c9af9f7805d7f3000001bd-1503014751.369548-710723835', 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 - Downloading/unpacking blobuploader==1.2.4 17:06:32 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:32 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:32 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:32 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 - Downloading blobuploader-1.2.4.tar.gz 17:06:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:06:33 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 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:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:06:34 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:06:34 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:34 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:34 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:34 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:34 INFO - Downloading docopt-0.6.1.tar.gz 17:06:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:06:34 INFO - Installing collected packages: blobuploader, requests, docopt 17:06:34 INFO - Running setup.py install for blobuploader 17:06:34 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:06:34 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:06:34 INFO - Running setup.py install for requests 17:06:34 INFO - Running setup.py install for docopt 17:06:34 INFO - Successfully installed blobuploader requests docopt 17:06:34 INFO - Cleaning up... 17:06:34 INFO - Return code: 0 17:06:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:06:34 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:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:06:34 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:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:06:34 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 0x2a4e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b52a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cf5ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cf30b0>, '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 0x2cf3fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cf4440>, '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': '88e9d754c8c9af9f7805d7f3000001bd-1503014751.369548-710723835', '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:34 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:34 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:34 INFO - Using env: {'DISPLAY': ':0', 17:06:34 INFO - 'HOME': '/home/cltbld', 17:06:34 INFO - 'LANG': 'en_US.UTF-8', 17:06:34 INFO - 'LANGUAGE': 'en_US:en', 17:06:34 INFO - 'LOGNAME': 'cltbld', 17:06:34 INFO - 'MAIL': '/var/mail/cltbld', 17:06:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:06:34 INFO - 'MOZ_NO_REMOTE': '1', 17:06:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:06:34 INFO - 'NO_EM_RESTART': '1', 17:06:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:06:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:06:34 INFO - 'PWD': '/builds/slave/test', 17:06:34 INFO - 'SHELL': '/bin/bash', 17:06:34 INFO - 'SHLVL': '1', 17:06:34 INFO - 'TERM': 'linux', 17:06:34 INFO - 'TMOUT': '86400', 17:06:34 INFO - 'USER': 'cltbld', 17:06:34 INFO - 'XDG_SESSION_COOKIE': '88e9d754c8c9af9f7805d7f3000001bd-1503014751.369548-710723835', 17:06:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:06:34 INFO - '_': '/tools/buildbot/bin/python'} 17:06:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:06:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:06:35 INFO - Running setup.py (path:/tmp/pip-vuYzER-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:06:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:06:35 INFO - Running setup.py (path:/tmp/pip-Dh4_VC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:06:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:06:35 INFO - Running setup.py (path:/tmp/pip-fwQFQA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:06:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:06:35 INFO - Running setup.py (path:/tmp/pip-dn_IRf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:06:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:06:35 INFO - Running setup.py (path:/tmp/pip-0eWPIN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:06:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:06:35 INFO - Running setup.py (path:/tmp/pip-oHgcez-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:06:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:06:35 INFO - Running setup.py (path:/tmp/pip-FdlpSN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:06:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:06:35 INFO - Running setup.py (path:/tmp/pip-V6el0i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:06:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:06:35 INFO - Running setup.py (path:/tmp/pip-WQsjID-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:06:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:06:35 INFO - Running setup.py (path:/tmp/pip-gJytZU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:06:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:06:35 INFO - Running setup.py (path:/tmp/pip-fth3vS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:06:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:06:35 INFO - Running setup.py (path:/tmp/pip-dnAZVF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:06:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:06:36 INFO - Running setup.py (path:/tmp/pip-v2JhLs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:06:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:06:36 INFO - Running setup.py (path:/tmp/pip-paW2xy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:06:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:06:36 INFO - Running setup.py (path:/tmp/pip-U66MQI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:06:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:06:36 INFO - Running setup.py (path:/tmp/pip-Z_8pxU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:06:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:06:36 INFO - Running setup.py (path:/tmp/pip-qAL4xp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:06:36 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:06:36 INFO - Running setup.py install for manifestparser 17:06:36 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:06:36 INFO - Running setup.py install for mozcrash 17:06:36 INFO - Running setup.py install for mozdebug 17:06:36 INFO - Running setup.py install for mozdevice 17:06:36 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:06:36 INFO - Running setup.py install for mozfile 17:06:36 INFO - Running setup.py install for mozhttpd 17:06:36 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:06:36 INFO - Running setup.py install for mozinfo 17:06:37 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:06:37 INFO - Running setup.py install for mozInstall 17:06:37 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:06:37 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:06:37 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:06:37 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:06:37 INFO - Running setup.py install for mozleak 17:06:37 INFO - Running setup.py install for mozlog 17:06:37 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:06:37 INFO - Running setup.py install for moznetwork 17:06:37 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:06:37 INFO - Running setup.py install for mozprocess 17:06:37 INFO - Running setup.py install for mozprofile 17:06:37 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:06:37 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:06:37 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:06:37 INFO - Running setup.py install for mozrunner 17:06:37 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:06:37 INFO - Running setup.py install for mozscreenshot 17:06:37 INFO - Running setup.py install for moztest 17:06:38 INFO - Running setup.py install for mozversion 17:06:38 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:06:38 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:06:38 INFO - Cleaning up... 17:06:38 INFO - Return code: 0 17:06:38 INFO - Installing None 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', '-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 0x2a4e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b52a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cf5ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cf30b0>, '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 0x2cf3fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cf4440>, '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': '88e9d754c8c9af9f7805d7f3000001bd-1503014751.369548-710723835', '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', '-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:38 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: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': '88e9d754c8c9af9f7805d7f3000001bd-1503014751.369548-710723835', 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 - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:06:38 INFO - Running setup.py (path:/tmp/pip-uBxJZy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:06:38 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:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:06:38 INFO - Running setup.py (path:/tmp/pip-Kdzpb7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:06:38 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:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:06:38 INFO - Running setup.py (path:/tmp/pip-hminoJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:06:38 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:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:06:38 INFO - Running setup.py (path:/tmp/pip-aADFIu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:06:38 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:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:06:38 INFO - Running setup.py (path:/tmp/pip-EyqwCf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:06:38 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:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:06:38 INFO - Running setup.py (path:/tmp/pip-mnLG0w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:06:38 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:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:06:38 INFO - Running setup.py (path:/tmp/pip-COPiRP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:06:38 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:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:06:38 INFO - Running setup.py (path:/tmp/pip-dIqea3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:06:38 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:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:06:38 INFO - Running setup.py (path:/tmp/pip-X0_DVV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:06:39 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:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:06:39 INFO - Running setup.py (path:/tmp/pip-csYG16-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:06:39 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:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:06:39 INFO - Running setup.py (path:/tmp/pip-0SRraq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:06:39 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:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:06:39 INFO - Running setup.py (path:/tmp/pip-HV8Czy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:06:39 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:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:06:39 INFO - Running setup.py (path:/tmp/pip-k6LjTJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:06:39 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:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:06:39 INFO - Running setup.py (path:/tmp/pip-Pl9MZA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:06:39 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:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:06:39 INFO - Running setup.py (path:/tmp/pip-umxF1v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:06:39 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:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:06:39 INFO - Running setup.py (path:/tmp/pip-fOMQuZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:06:39 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:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:06:39 INFO - Running setup.py (path:/tmp/pip-QWnIH0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:06:39 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:39 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:39 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:39 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:39 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:39 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:39 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:39 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:06:39 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:39 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:39 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:39 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:40 INFO - Downloading blessings-1.6.tar.gz 17:06:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:06:40 INFO - Installing collected packages: blessings 17:06:40 INFO - Running setup.py install for blessings 17:06:40 INFO - Successfully installed blessings 17:06:40 INFO - Cleaning up... 17:06:40 INFO - Return code: 0 17:06:40 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:06:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:06:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:06:41 INFO - Reading from file tmpfile_stdout 17:06:41 INFO - Current package versions: 17:06:41 INFO - argparse == 1.2.1 17:06:41 INFO - blessings == 1.6 17:06:41 INFO - blobuploader == 1.2.4 17:06:41 INFO - docopt == 0.6.1 17:06:41 INFO - functools32 == 3.2.3-2 17:06:41 INFO - jsonschema == 2.5.1 17:06:41 INFO - manifestparser == 1.1 17:06:41 INFO - mozInstall == 1.13 17:06:41 INFO - mozcrash == 1.0 17:06:41 INFO - mozdebug == 0.1 17:06:41 INFO - mozdevice == 0.51 17:06:41 INFO - mozfile == 1.2 17:06:41 INFO - mozhttpd == 0.7 17:06:41 INFO - mozinfo == 0.10 17:06:41 INFO - mozleak == 0.1 17:06:41 INFO - mozlog == 3.5 17:06:41 INFO - moznetwork == 0.27 17:06:41 INFO - mozprocess == 0.25 17:06:41 INFO - mozprofile == 0.28 17:06:41 INFO - mozrunner == 6.13 17:06:41 INFO - mozscreenshot == 0.1 17:06:41 INFO - mozsystemmonitor == 0.3 17:06:41 INFO - moztest == 0.8 17:06:41 INFO - mozversion == 1.4 17:06:41 INFO - psutil == 3.1.1 17:06:41 INFO - requests == 1.2.3 17:06:41 INFO - wsgiref == 0.1.2 17:06:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:06:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:06:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:06:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:06:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:06:41 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 0x2a4e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b52a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cf5ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cf30b0>, '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 0x2cf3fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cf4440>, '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': '88e9d754c8c9af9f7805d7f3000001bd-1503014751.369548-710723835', '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:41 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:41 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:41 INFO - Using env: {'DISPLAY': ':0', 17:06:41 INFO - 'HOME': '/home/cltbld', 17:06:41 INFO - 'LANG': 'en_US.UTF-8', 17:06:41 INFO - 'LANGUAGE': 'en_US:en', 17:06:41 INFO - 'LOGNAME': 'cltbld', 17:06:41 INFO - 'MAIL': '/var/mail/cltbld', 17:06:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:06:41 INFO - 'MOZ_NO_REMOTE': '1', 17:06:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:06:41 INFO - 'NO_EM_RESTART': '1', 17:06:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:06:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:06:41 INFO - 'PWD': '/builds/slave/test', 17:06:41 INFO - 'SHELL': '/bin/bash', 17:06:41 INFO - 'SHLVL': '1', 17:06:41 INFO - 'TERM': 'linux', 17:06:41 INFO - 'TMOUT': '86400', 17:06:41 INFO - 'USER': 'cltbld', 17:06:41 INFO - 'XDG_SESSION_COOKIE': '88e9d754c8c9af9f7805d7f3000001bd-1503014751.369548-710723835', 17:06:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:06:41 INFO - '_': '/tools/buildbot/bin/python'} 17:06:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:06:41 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:41 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:41 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:41 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:41 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:41 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:41 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:41 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:41 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:41 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 17:06:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:06:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:06:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:06:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:06:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 17:06:42 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:42 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:42 INFO - Installing collected packages: simplejson 17:06:42 INFO - Running setup.py install for simplejson 17:06:42 INFO - building 'simplejson._speedups' extension 17:06:42 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:43 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:43 INFO - Successfully installed simplejson 17:06:43 INFO - Cleaning up... 17:06:43 INFO - Return code: 0 17:06:43 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:06:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:06:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:06:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:06:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:06:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a4e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b52a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cf5ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cf30b0>, '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 0x2cf3fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cf4440>, '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': '88e9d754c8c9af9f7805d7f3000001bd-1503014751.369548-710723835', '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:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 17:06:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 17:06:43 INFO - Using env: {'DISPLAY': ':0', 17:06:43 INFO - 'HOME': '/home/cltbld', 17:06:43 INFO - 'LANG': 'en_US.UTF-8', 17:06:43 INFO - 'LANGUAGE': 'en_US:en', 17:06:43 INFO - 'LOGNAME': 'cltbld', 17:06:43 INFO - 'MAIL': '/var/mail/cltbld', 17:06:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:06:43 INFO - 'MOZ_NO_REMOTE': '1', 17:06:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:06:43 INFO - 'NO_EM_RESTART': '1', 17:06:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:06:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:06:43 INFO - 'PWD': '/builds/slave/test', 17:06:43 INFO - 'SHELL': '/bin/bash', 17:06:43 INFO - 'SHLVL': '1', 17:06:43 INFO - 'TERM': 'linux', 17:06:43 INFO - 'TMOUT': '86400', 17:06:43 INFO - 'USER': 'cltbld', 17:06:43 INFO - 'XDG_SESSION_COOKIE': '88e9d754c8c9af9f7805d7f3000001bd-1503014751.369548-710723835', 17:06:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:06:43 INFO - '_': '/tools/buildbot/bin/python'} 17:06:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:06:43 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 17:06:43 INFO - Cleaning up... 17:06:43 INFO - Return code: 0 17:06:43 INFO - Running post-action listener: _resource_record_post_action 17:06:43 INFO - Running post-action listener: _start_resource_monitoring 17:06:43 INFO - Starting resource monitoring. 17:06:43 INFO - [mozharness: 2017-08-18 00:06:43.921562Z] Finished create-virtualenv step (success) 17:06:43 INFO - [mozharness: 2017-08-18 00:06:43.922070Z] Running install step. 17:06:43 INFO - Running pre-action listener: _resource_record_pre_action 17:06:43 INFO - Running main action method: install 17:06:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:06:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:06:44 INFO - Reading from file tmpfile_stdout 17:06:44 INFO - Detecting whether we're running mozinstall >=1.0... 17:06:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:06:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:06:44 INFO - Reading from file tmpfile_stdout 17:06:44 INFO - Output received: 17:06:44 INFO - Usage: mozinstall [options] installer 17:06:44 INFO - Options: 17:06:44 INFO - -h, --help show this help message and exit 17:06:44 INFO - -d DEST, --destination=DEST 17:06:44 INFO - Directory to install application into. [default: 17:06:44 INFO - "/builds/slave/test"] 17:06:44 INFO - --app=APP Application being installed. [default: firefox] 17:06:44 INFO - mkdir: /builds/slave/test/build/application 17:06:44 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:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 17:07:02 INFO - Reading from file tmpfile_stdout 17:07:02 INFO - Output received: 17:07:02 INFO - /builds/slave/test/build/application/firefox/firefox 17:07:02 INFO - Running post-action listener: _resource_record_post_action 17:07:02 INFO - [mozharness: 2017-08-18 00:07:02.294751Z] Finished install step (success) 17:07:02 INFO - [mozharness: 2017-08-18 00:07:02.295003Z] Running setup-mitmproxy step. 17:07:02 INFO - Running pre-action listener: _resource_record_pre_action 17:07:02 INFO - Running main action method: setup_mitmproxy 17:07:02 INFO - Skipping: mitmproxy is not required 17:07:02 INFO - Running post-action listener: _resource_record_post_action 17:07:02 INFO - [mozharness: 2017-08-18 00:07:02.296140Z] Finished setup-mitmproxy step (success) 17:07:02 INFO - [mozharness: 2017-08-18 00:07:02.296359Z] Running run-tests step. 17:07:02 INFO - Running pre-action listener: _resource_record_pre_action 17:07:02 INFO - Running pre-action listener: _set_gcov_prefix 17:07:02 INFO - Running main action method: run_tests 17:07:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:07:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:07:02 INFO - Python 2.7.3 17:07:02 INFO - Return code: 0 17:07:02 INFO - grabbing minidump binary from tooltool 17:07:02 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:07:02 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 0x2cf30b0>, '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 0x2cf3fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cf4440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:07:02 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:07:02 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:07:02 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:07:02 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:07:02 INFO - Return code: 0 17:07:02 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 17:07:02 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:07:02 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:07:02 INFO - ENV: RUST_BACKTRACE is now full 17:07:02 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 17:07:02 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:07:02 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-044', '--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:07:02 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-044 --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:07:02 INFO - Using env: {'DISPLAY': ':0', 17:07:02 INFO - 'HOME': '/home/cltbld', 17:07:02 INFO - 'LANG': 'en_US.UTF-8', 17:07:02 INFO - 'LANGUAGE': 'en_US:en', 17:07:02 INFO - 'LOGNAME': 'cltbld', 17:07:02 INFO - 'MAIL': '/var/mail/cltbld', 17:07:02 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:07:02 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:07:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:07:02 INFO - 'MOZ_NO_REMOTE': '1', 17:07:02 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:07:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:07:02 INFO - 'NO_EM_RESTART': '1', 17:07:02 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:07:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:07:02 INFO - 'PWD': '/builds/slave/test', 17:07:02 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:07:02 INFO - 'RUST_BACKTRACE': 'full', 17:07:02 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 17:07:02 INFO - 'SHELL': '/bin/bash', 17:07:02 INFO - 'SHLVL': '1', 17:07:02 INFO - 'STYLO_FORCE_ENABLED': '1', 17:07:02 INFO - 'TERM': 'linux', 17:07:02 INFO - 'TMOUT': '86400', 17:07:02 INFO - 'USER': 'cltbld', 17:07:02 INFO - 'XDG_SESSION_COOKIE': '88e9d754c8c9af9f7805d7f3000001bd-1503014751.369548-710723835', 17:07:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:07:02 INFO - '_': '/tools/buildbot/bin/python'} 17:07:02 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-044', '--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:07:02 INFO - mozversion application_buildid: 20170817231714 17:07:02 INFO - mozversion application_changeset: a6a1f5c1d971dbee67ba6eec7ead7902351ddca2 17:07:02 INFO - mozversion application_display_name: Nightly 17:07:02 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:07:02 INFO - mozversion application_name: Firefox 17:07:02 INFO - mozversion application_remotingname: firefox 17:07:02 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 17:07:02 INFO - mozversion application_vendor: Mozilla 17:07:02 INFO - mozversion application_version: 57.0a1 17:07:02 INFO - mozversion platform_buildid: 20170817231714 17:07:02 INFO - mozversion platform_changeset: a6a1f5c1d971dbee67ba6eec7ead7902351ddca2 17:07:02 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 17:07:02 INFO - mozversion platform_version: 57.0a1 17:07:02 INFO - using testdate: 1503014822 17:07:02 INFO - actual date: 1503014822 17:07:02 INFO - starting webserver on 'localhost:55652' 17:07:02 INFO - SUITE-START | Running 2 tests 17:07:02 INFO - TEST-START | dromaeo_css 17:07:02 INFO - Initialising browser for dromaeo_css test... 17:07:02 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:55652/getInfo.html -profile /tmp/tmpb_x7ls/profile 17:07:02 INFO - TEST-INFO | started process 2708 (/builds/slave/test/build/application/firefox/firefox http://localhost:55652/getInfo.html) 17:07:08 INFO - TEST-INFO | 2708: exit 0 17:07:08 INFO - Browser initialized. 17:07:08 INFO - Running cycle 1/1 for dromaeo_css test... 17:07:08 INFO - TEST-INFO | started process 2999 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpb_x7ls/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 17:07:09 INFO - PID 2999 | 17:07:09 INFO - PID 2999 | (/builds/slave/test/build/application/firefox/firefox:3053): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 17:07:09 INFO - PID 2999 | 17:07:19 INFO - PID 2999 | RSS: Main: 169910272 17:07:19 INFO - PID 2999 | 17:10:18 INFO - PID 2999 | Cycle 1(1): loaded http://localhost:55652/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55652/tests/dromaeo/cssquery-ext.html) 17:10:19 INFO - PID 2999 | RSS: Main: 174997504 17:10:19 INFO - PID 2999 | 17:13:21 INFO - PID 2999 | Cycle 1(1): loaded http://localhost:55652/tests/dromaeo/cssquery-ext.html (next: http://localhost:55652/tests/dromaeo/cssquery-jquery.html) 17:13:22 INFO - PID 2999 | RSS: Main: 171667456 17:13:22 INFO - PID 2999 | 17:16:24 INFO - PID 2999 | Cycle 1(1): loaded http://localhost:55652/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55652/tests/dromaeo/cssquery-mootools.html) 17:16:24 INFO - PID 2999 | RSS: Main: 172318720 17:16:24 INFO - PID 2999 | 17:19:26 INFO - PID 2999 | Cycle 1(1): loaded http://localhost:55652/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55652/tests/dromaeo/cssquery-prototype.html) 17:19:27 INFO - PID 2999 | RSS: Main: 172396544 17:19:27 INFO - PID 2999 | 17:22:30 INFO - PID 2999 | Cycle 1(1): loaded http://localhost:55652/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55652/tests/dromaeo/cssquery-yui.html) 17:22:31 INFO - PID 2999 | RSS: Main: 175661056 17:22:31 INFO - PID 2999 | 17:25:33 INFO - PID 2999 | Cycle 1(1): loaded http://localhost:55652/tests/dromaeo/cssquery-yui.html (next: http://localhost:55652/tests/dromaeo/cssquery-dojo.html) 17:25:33 INFO - PID 2999 | RSS: Main: 176103424 17:25:33 INFO - PID 2999 | 17:25:33 INFO - PID 2999 | __start_tp_report 17:25:33 INFO - PID 2999 | _x_x_mozilla_page_load 17:25:33 INFO - PID 2999 | _x_x_mozilla_page_load_details 17:25:33 INFO - PID 2999 | |i|pagename|runs| 17:25:33 INFO - PID 2999 | |0;dojo.html;3147.4334619768447;3152.0701393089034;3176.6664500227475;3185.10816971248;3190.34597907429;6073.665948372838;6241.875162496747;6262.749490020394;6291.307956124822;6325.746970121189;6023.337432882379;6191.4737247333915;6191.845203869905;6202.193714817067;6223.159873417098;5597.328320601534;5604.859878503029;5650.886982260352;5672.829815105553;5784.161296611988;5709.0580054290995;5769.740361683714;5785.190073389729;5793.507551858097;5810.970945145268;5562.499375056264;5679.687617181074;5686.914696279559;5734.483896449339;5747.741351639165;5670.092785154397;5709.714514274269;5723.456271654228;5732.111522713986;5772.595918285721;5639.069553523664;5642.4357564243655;5716.57125715573;5720.370759216483;5733.799317023884;6074.301455332605;6077.787277445268;6104.450599446027;6113.663748493831;6254.374562543755;6555.573887697332;6584.637844918528;6589.835254118685;6620.9006864897065;6668.199816022108;6747.257801641816;6764.255931847493;6775.898361524581;6784.694688739019;6794.0827988221945;6173.290071641729;6259.217597800275;6273.027680709497;6283.246010478726;6294.905576416358;6754.527183097136;6864.691088901011;6871.690773915186;6963.059986901805;6996.230414654384;6392.872142557216;6486.708098135595;6497.18785151856;6617.834554136185;6626.138601981712;6687.331266873273;6700.262971073178;6717.865642687118;6742.93257067423;6756.594604323756;6615.801525954229;6633.701483433257;6701.39687428124;6704.296048914891;6713.765018224339;6664.8000559983275;6685.364890335411;6747.865042699119;6761.053452516651;6766.120404347404;5025.447200807908;5054.9241761373605;5087.287779710843;5100.005498927673;5104.821331253388;4392.407025051577;4421.602055814992;4428.667849911205;4429.424174857248;4451.3323001550025;5675.318961724537;5744.253247077853;5759.884802304015;5780.508656764138;5791.88416231673;6603.504737144734;6650.833729156713;6677.76627818024;6735.4274886635185;6771.796846094625;5652.18043383707;5717.514011309086;5725.656460612377;5818.76724930998;5821.446962538552;5835.358110607915;5842.561807864342;5921.378255283219;5942.197803296586;5944.554158438134;6473.708683109177;6489.415952564197;6512.316206798313;6521.152250207538;6544.247411547733;6691.966540167268;6697.598144111369;6776.390124888882;6788.1175447191545;6807.115075040411;6340.080688300263;6402.327755585597;6418.326075762165;6419.197600299963;6525;6511.706973186313;6572.34276572339;6583.868322633616;6603.174603174603;6605.240397354366;6605.735770569124;6674.332566743286;6689.364510371507;6692.196936367667;6694.765683201259;6404.647744373918;6492.5455218134275;6493.4155925965;6494.0258961156205;6496.317886621837;6388.425041746265;6389.584676995981;6480.546361754632;6483.319251478527;6488.091667166695;6295.842603934938;6335.429811317003;6374.936250637435;6387.329330420424;6407.743690252338;6388.488920886411;6458.935410646021;6460.547761656639;6476.740930362733;6577.2436169841085;6368.904466432915;6392.264889537577;6442.033694945608;6449.935500644933;6450.774222902176 17:25:33 INFO - PID 2999 | |1;ext.html;786.1470304719379;841.2092632925049;862.6075135813202;866.1252135343301;1158.7624536969922;39684.603153968485;40514.59485405145;40684.186316273655;40685.389719154235;40746.59253407473;41560.58439415605;41938.58061419385;41945.58054419455;42032;42038.789806050925;7721.420893432987;7796.103448103484;7829.686812527492;7837.529748215097;7848.6860525579195;7648.808779780522;7757.26306000929;7805.531668099932;7809.492382995116;7810.2189781021725;7303.488755787097;7818.413618978571;7851.5681637509915;7853.64658590362;7894.4868583542175;7781.494202876823;7845;7846.097698764658;7849.175836537167;7849.215078492162;7661.885071723928;7706.152323244439;7749.031371078615;7755;7757.146713861471;37459.06352341186;37650.623493764986;37719;38340;38739;3603.891883243507;3644.69020133289;3646.4530320452145;3646.74472786905;3648.343298206322;31774.205644859063;31800.840995795104;31811.681883181103;31923.201919951956;31933.840330798197;5047.772850221749;5076.289319495274;5081.771320290596;5093.872653183663;5118.206677964884;196531;196945;197194;198009;198055.99999999854;48105;48159.75920120377;48215.27677084847;48267.51732482701;48382.758086209345;50243.24635130476;50419.495805042214;50606.74696626493;50702.74648626733;50757;15942.760858587131;16080.758788618181;16182.838171618369;16205.270762815702;16233.188340582923;13257.933710331386;13304.13523120994;13317.533886314126;13329.400176992058;13358.131721438076;14112.223827689575;14218.360173792204;14288.35702393374;14351;14491.492797752238;5580.693061881554;5683.8863222736145;5842.444967728059;5905.911411328833;5924.407559244041;987.1411871671548;997.3467378866853;1001.2040427859869;1012.8885822559513;1013.6502906497246;23256.4185895354;28449.85775071153;28755.28111797222;29005.274868128465;29719.25701857471;1046.1526163807341;1058.5977328615077;1077.3589714120242;1081.729567608098;1084.2410312781085;12455.439505222286;12465.12744107922;12489.687757805947;12540.557835848995;12597.559085431965;245288;247363;247592;248178;248497;51149.23276150861;51199.7440012805;51238;51273.487265126874;51476.22785658218;1442.278860569715;1468.5667728020046;1491.358715752237;1491.9104853708811;1501.6020754500066;22290.88854555717;22647.433814154778;22780.316590502312;22808.885955570116;22833;37490;37596.436053458674;37649.81175094107;37659.81170094132;37673.62326376811;217804;218572;218779;219238;219389;33090;33134.17164570905;33344.49983250205;33395.83302083474;33417.16457088592;40308.798456008706;41929.37105943474;45849.312260315455;46998.29502557396;47368;30444.391112178077;34558.82720586381;36824.63175368319;37480.250394992494;38167.42748858825;37209;37344;37352.62647373491;37521.62478375181;38241.617583823805;40195.598044019185;40617;40900;40953;41043.38434923419;42881.57118428901;42950.570494295906;43117.35323970205;43153;43240.78379608082;23957.880210598836;26269.21192364232;26597.335066622716;26944.730552694222;27187 17:25:33 INFO - PID 2999 | |2;jquery.html;577.8237637520557;579.1457600039939;584.8742520358128;585.9443352881476;596.7791916990712;22484.43788905278;22841;23194.536109277804;23381.76618233817;23479.882600586974;26712.732872671266;27230.183094507145;27236.45527089457;27311;27355.726442735566;6582.967085164568;6727.192736871582;6736.29268926763;6738.225104113017;6739.561928474658;5958.940410595904;6507.31673174317;6510.5442619016685;6524.706388212542;6536.052272420497;6488.188976377953;6488.740450381979;6497.05792660064;6518.543701940866;6519.087327774116;6458.321876203002;6471.126397936266;6479.481641468671;6480.254770701383;6485.70814313357;6018.067199584071;6057.30341010785;6059.272887253558;6060.272767267912;6091.360407157274;30150.69849301501;30299.545506817416;30886.691133088607;31779;31949.361012779613;1918.2998205654976;1937.5253062999514;1937.883726976386;1943.7375954246138;1949.707543868417;19256.326028588934;19843.603127937506;19853.205871765113;19866.60266794656;19873.9006304969;2419.201663451057;2433.5497932882295;2465.2604218734486;2507.8244522883406;2514.6730924979634;137518;141313.29343353218;141434.2928285352;141593;141808;15129.167895765619;15455.613609659624;15555;15602.375904963901;15899.920500397424;23348.533029339316;23881.641775373384;24217.152399665927;24314.392140196636;24329.39176520601;10524.36853788775;10556.102731267774;10628.309159904582;10767.730806729895;10877.401742904058;9818.165455936183;9820.45987470696;9838.262130340254;9899.257555683353;10067.949660251652;9561.713148605413;9675.419474831533;9761.121499064977;9797.461139637388;9863.04108767367;2759.530879750447;2810.423863108099;2859.6711378191776;2881.4525240204293;2893.7540309073543;928.4986107502008;941.7598512379436;949.3354651743807;966.415318732157;970.5050424283667;20136.19455221775;20364.898175509028;20372.388828335173;20759.377218683465;20875.164993400092;1007.1036777268237;1020.5968642386364;1022.3763504262394;1041.7499800047933;1042.5308611125024;10941.890581094247;11112.444377781241;11227.21409501327;11241.83137252942;11282.605108821152;479543;492612;501405;501568;522997;117802.41098794452;118248;119091.40454297673;120771.79228207606;122624.38687806504;1201.1274687932669;1206.1135065726685;1226.926384416938;1232.8335674683804;1235.6293112066344;17466.73799893028;17484.650306994045;17734.556636083686;17845.10774461246;18557.072146392355;54264.72867635637;54756;54790.17814732862;58355.70822145862;58836.70581647065;70121;71977.6401117991;72337;72397.27602723906;72518;14972.176530290939;15220.391184352944;15458.458953937008;15543.611409714847;15554.688906222038;24073;24073.51852962966;24502.38744031342;24682;24854.254372368134;18733;18859.811401885807;19124.33064842724;19185.32851350196;19421.2231510738;16896.493105206864;17240.568985775455;17347.132643368033;17765.733513997042;17818.732719008967;19470.805291947465;19500.804991950467;19895.900520497304;19898.801011989694;20964;15066.623334416727;15111;15173.544793656209;15250.542483725507;15273.389064437299;18997.335093271668;19086.331978381244;19153.425397238105;19448.805511944698;19456.513587160433 17:25:33 INFO - PID 2999 | |3;mootools.html;1395.7348103860265;1450.4125829039235;1466.061720498881;1467.2443691498877;1472.5287907869485;13767.380467878944;14267.3579688914;14298.356573954172;14303.070300430478;14307.570772876805;13478.797818032737;14301.928490357559;14380.352884120213;14391.712165756679;14399.136051836897;2705.3371923878626;2742.698303186648;2751.2021513760988;2757.5036493431276;2759.11708253359;2620.9213723588227;2631.855247961371;2680.919572412831;2683.1950414875555;2685.194441667502;2636.4858852523766;2664.214056853233;2690.1391554702504;2717.1305182341657;2717.4565086982584;2616.4505453854713;2620.59380795976;2644.4975454663554;2650.218185635242;2661.9884443911383;2619.345163709073;2624.5407053765707;2640.339915021245;2649.9205023849318;2655.2830735701446;13576.117552359065;13752;13807.17156970585;13834.308284585832;13838.238896860668;7304.233055529199;7634.732784352521;7639.197884222132;7639.197884222132;7647.885281720779;4850.442199147108;4919.163742163841;4986.4514903360605;5073.315102461194;5083.3391659084455;1714.41709818661;1744.6685129825294;1744.834240747127;1769.1331247688668;1774.8757586968918;22739.20412785561;22866.970986305823;22879.656805147937;23069.76930230693;23094.191703290304;6337.8732425352155;6457.3865482779065;6622.437092847065;6635.635040072746;6686.7993960181275;16114.113723745071;16177;16182.352705891632;16208.51374458768;16224.35102595883;7354.191038985814;7509.173990861001;7510.361619262315;7510.699572017058;7512.060992375953;5583.4137415571595;5864.179014937912;6028.33688294296;6654.334566543307;6868.038474613558;4971.502849715;5132.486751324912;5164.690118592896;5171.120909445328;5293.550048245866;1440.9481078812526;1445.869871711551;1472.4919902633574;1499.9400023998917;1505.1871989125968;914.1315750037359;932.7341707613298;933.1135421349745;936.5551363102608;940.8541676040225;7178.748743793943;7383.963080184565;7385.704571817175;7415.1101867776215;7425.146108197627;681.8499930015389;700.198272977438;708.7661071846278;728.6757392960188;735.8086897406713;4771.498992605726;5190.480951904855;5286.15421532553;5334.51989320963;5401.378841433207;18358;18465.076746162908;19014.049297535068;19193.712094318595;19203.519912002314;18685.252589896252;18688.813111868978;18800;18904;18961.620767584573;10148.137408320375;10562.524686388977;10750.8387374191;10788.730281743019;10793.352398856094;8599.312055035458;8655;8730.214280714767;8758.12418758119;8764.693235736719;16496.092714900795;16914.238859251116;16959.576010599834;17048.147592620073;17206.999999999498;16624.667506650043;16870.493885183463;17100.65798684044;17223.3971810986;17355.30578776885;11442.713932151762;11530.365829879102;11595.072394208612;11627.767444651228;11646.65060048166;13084.411201496147;13164;13179.40692668813;13185.208887466782;13213.933930330288;10782.1913356497;10792.56829726802;10885.782284354427;10908.400037997986;11095;10485.895141048797;10617.469126543796;10628.202884783517;10713.303635263683;10935.617253396093;9321;9469.47917864524;9579.568919398504;9585.952070239604;9587.568559414703;6930.341617546325;6965.44276457872;7066.4700147490175;7077.610731409822;7079.29207079288;7187.389071928945;7241.275872412716;7266.818329541804;7311;7317.304856038668 17:25:33 INFO - PID 2999 | |4;prototype.html;495.41045190510914;502.45232696360983;509.68399592252797;527.0644605824658;528.1575886461096;6202.7208775605095;6232.3456037116075;6268.37316268373;6284.434400903918;6312.589681670694;6033.668148251844;6122.602030867991;6130.785422510213;6148.231471066117;6184.103305020781;5013.799448022075;5027.597792176635;5056.191009438472;5086;5095;4796.83211087612;4983.950160498385;5019.673721208128;5059.949400506003;5062.417821950486;4907.2884431757375;4916.262560615918;4955.727434991074;4966.255061740731;4978.377702787152;4907.582855457273;4916.237983112624;4953.133201689726;4955.702657840541;4958.553730164284;4410.6030457259;4421.977890110561;4465.441819772528;4539;4543.954560454386;5970.910436343458;6086.960868109189;6096.359882212349;6106.72519736613;6141.744875216143;5653.8586535336535;5699.601027928046;5711.514521265697;5722.62802917809;5774.2782152230975;6565.848392771449;6570.310117437648;6585.80242592723;6606.8017959461295;6607.636579988099;4927.088488629579;4930.556249937487;4953.777080031371;4955.752212389366;4958.851234462972;6715.5488246790055;6780.254172041072;6866.210385805646;6901.585904845725;6979.616121113337;4975.850724478271;5007.372603903673;5008.223725322581;5076.695398276115;5088.389393272757;5088.262201980692;5090.134677104901;5091.592672586185;5136.8202112925865;5164.04465173944;5673.120666296648;5704.515116215085;5705.145827606045;5736.311642602915;5749.568782341257;6335.461485773669;6508.349165083454;6524.380183882524;6594.86810263792;6646.567973081831;1703.4073141612632;1746.4585978346754;1746.6244757377224;1786.5980154465142;1788.2578729827237;1201.3512703140382;1228.6007047709352;1238.4303220518482;1250.1124201816813;1251.4806355362423;5671.319441666944;5675.5459563234845;5690.630109042899;5704.286964129484;5783.566232532577;6676.899846502306;6735.5002422662365;6790;6802.14973128359;6937.861242775217;5754.223179870663;5767.336756272998;5813.767449302065;5834.095715164071;5906.202662640574;3589.4795254687924;3597.5323207982797;3617.077645200457;3638.653068770628;3647.325244829715;6630.53586248958;6663.400293973566;6672.566283191577;6689.799306020827;6736.562123461959;7032.753853615099;7039.225685174627;7053.788386348418;7065.399441047569;7111.182214045451;6500.154979852683;6534;6555.115059466911;6555.410013098844;6600.86798264032;6714.3957043866285;6749.763758268437;6758.594484330956;6790.626515541495;6808.523403361717;6594.736210551524;6791.864162716817;6807.311112110788;6813.921753864921;6851.862962740817;6534.640594767143;6552.770653027121;6585.440237579859;6612.140421745143;6686.866262674622;4984.277279794482;5038.118329292286;5043.42000669913;5057.848264552069;5082.33929589151;6471.741130354733;6716.798496044931;6808.217055038734;6860.5540639858245;6862.691178897061;6443.2590252119735;6448.516361272829;6459.321771213955;6603.735850565923;6683.799486015428;6519.4784417245555;6520.478361731145;6544.247411547733;6623.933760662332;6667.733290668513;6347.619142851444;6427.903581446376;6445.613263204223;6527.3472652734345;6590.978398348264;6570.911671514381;6591.835204119743;6645.036469711961;6666.766663166766;6691.364320389555;6457.4511166551365;6464.41820236181;6472.449841763315;6488.6755662215755;6511.902321465087 17:25:33 INFO - PID 2999 | |5;yui.html;904.895936967249;920.4707293306351;922.2621902478018;926.0230456868006;937.0863408177026;18758.2496700132;19855;19875;19883.701744473827;21054.263100791475;22104.557908841813;22558.661620075673;22602.77397226027;22626;22665.773342266573;1031.365710088294;1034.312182398704;1035.927485076045;1050.2700623066933;1055.3298655353829;1026.856240126383;1047.711879233213;1048.0305717211586;1050.679542739464;1059.607945060325;1113.899749022588;1119.3787447966376;1120.5069769301522;1121.5850135449896;1124.3647339253296;1101.3281898042187;1110.4392281897672;1116.8157254053071;1119.356370087203;1120.2158489057651;815.1807433529324;815.7675062607187;816.0085496122181;820.0774129104757;821.7822277096574;20310.695339569917;20451.48871278215;20568.897155514125;20575.485612859648;21238.89380553103;21608.675869861963;21840.23559175421;21923.23268685604;22150.446238844157;22299.55400891989;17080.14599270044;17225.483235502954;17449.21478533469;17457.21442535089;17690.734638980426;3610.295992281506;3621.112827357288;3636.909077273063;3636.9272614547826;3637.199816040467;129081.35459322737;130654;131010.34494827465;132425;134296.32851835777;16055.598610034609;16111.677766444605;16868.24092915822;17116.828831711522;17166.313347465963;29670.406591868043;30803.69196308053;30933.535996960065;31543.21141971469;31562.526562101586;7836.608169591497;8191.672333106728;8785.428947118417;8800.075992020873;9205.585748641328;4301.161273551627;4368.060866913629;4373.278409062469;4383.408239887638;4400.295952647625;5312.309399778082;5386.946130538723;5405;5446.101393270145;5507.642003269774;1016.9898301017043;1031.4791030529534;1047.863777708893;1054.0408228512017;1057.3919996002176;705.108038331511;720.3157000849214;720.6252748570714;731.4112139727571;748.4835463530255;11831.349275789915;11839.88160118405;11894.226875253082;11998.820017699742;12239.938800305941;643.4723526708148;656.4977791989132;714.2857142857143;717.7021536062475;722.458156382713;5418.620696551204;5556.527695145877;5569.108942569251;5813.912791308134;5950.166976623276;107589;107865.46067269614;111381.44309278401;113654.43172784083;114033;94553.5272323634;99835.50082249542;101464;101543.44597939037;102308.48845755872;86266.56866715626;89144;89880.55059724659;90872.5456372714;91057.54471227733;12407.193532420364;12827.486900524247;12832.935835320764;13151.671208219872;13447.125936814076;41068;41430.585694142675;41536.584634153274;41930.790346048074;42071.3689294667;71049.28950710427;71918.28081719116;72170.63914680394;74522;75063.74808755745;19300.131494082518;20354.79645203529;20671.17315307371;20768.584628307046;20923;22509;22900.885495572416;22909.770902290762;23031.424214394774;23272;19835.702464462756;19936.20255189776;20156.59686806285;20557.58884822265;20785.06467208949;19997.900010499856;20280.89859550693;20339.491512712302;20741.688874667194;20760.48098797542;19572.902135489232;20201.292954746514;20244.392668219978;20388.79611203869;20420.591588168452;12986.35068246565;13843.4462621494;13935.09421887574;13942.512012079529;14038.227897465737;14813.777793332893;15418.614534636723;15453.768193477332;15622.453214137451;15720.135392553062 17:25:33 INFO - PID 2999 | __end_tp_report 17:25:33 INFO - PID 2999 | __start_cc_report 17:25:33 INFO - PID 2999 | _x_x_mozilla_cycle_collect,383 17:25:33 INFO - PID 2999 | __end_cc_report 17:25:33 INFO - PID 2999 | __startTimestamp1503015933633__endTimestamp 17:25:33 INFO - PID 2999 | 17:25:33 INFO - PID 2999 | ------- Summary: start ------- 17:25:33 INFO - PID 2999 | Number of tests: 6 17:25:33 INFO - PID 2999 | 17:25:33 INFO - PID 2999 | [#0] dojo.html Cycles:165 Average:6123.75 Median:6388.49 stddev:749.15 (11.7%) stddev-sans-first:714.13 17:25:33 INFO - PID 2999 | Values: 3147.4 3152.1 3176.7 3185.1 3190.3 6073.7 6241.9 6262.7 6291.3 6325.7 6023.3 6191.5 6191.8 6202.2 6223.2 5597.3 5604.9 5650.9 5672.8 5784.2 5709.1 5769.7 5785.2 5793.5 5811.0 5562.5 5679.7 5686.9 5734.5 5747.7 5670.1 5709.7 5723.5 5732.1 5772.6 5639.1 5642.4 5716.6 5720.4 5733.8 6074.3 6077.8 6104.5 6113.7 6254.4 6555.6 6584.6 6589.8 6620.9 6668.2 6747.3 6764.3 6775.9 6784.7 6794.1 6173.3 6259.2 6273.0 6283.2 6294.9 6754.5 6864.7 6871.7 6963.1 6996.2 6392.9 6486.7 6497.2 6617.8 6626.1 6687.3 6700.3 6717.9 6742.9 6756.6 6615.8 6633.7 6701.4 6704.3 6713.8 6664.8 6685.4 6747.9 6761.1 6766.1 5025.4 5054.9 5087.3 5100.0 5104.8 4392.4 4421.6 4428.7 4429.4 4451.3 5675.3 5744.3 5759.9 5780.5 5791.9 6603.5 6650.8 6677.8 6735.4 6771.8 5652.2 5717.5 5725.7 5818.8 5821.4 5835.4 5842.6 5921.4 5942.2 5944.6 6473.7 6489.4 6512.3 6521.2 6544.2 6692.0 6697.6 6776.4 6788.1 6807.1 6340.1 6402.3 6418.3 6419.2 6525.0 6511.7 6572.3 6583.9 6603.2 6605.2 6605.7 6674.3 6689.4 6692.2 6694.8 6404.6 6492.5 6493.4 6494.0 6496.3 6388.4 6389.6 6480.5 6483.3 6488.1 6295.8 6335.4 6374.9 6387.3 6407.7 6388.5 6458.9 6460.5 6476.7 6577.2 6368.9 6392.3 6442.0 6449.9 6450.8 17:25:33 INFO - PID 2999 | 17:25:33 INFO - PID 2999 | [#1] ext.html Cycles:180 Average:39686.90 Median:37650.22 stddev:57537.88 (152.8%) stddev-sans-first:57625.15 17:25:33 INFO - PID 2999 | Values: 786.1 841.2 862.6 866.1 1158.8 39684.6 40514.6 40684.2 40685.4 40746.6 41560.6 41938.6 41945.6 42032.0 42038.8 7721.4 7796.1 7829.7 7837.5 7848.7 7648.8 7757.3 7805.5 7809.5 7810.2 7303.5 7818.4 7851.6 7853.6 7894.5 7781.5 7845.0 7846.1 7849.2 7849.2 7661.9 7706.2 7749.0 7755.0 7757.1 37459.1 37650.6 37719.0 38340.0 38739.0 3603.9 3644.7 3646.5 3646.7 3648.3 31774.2 31800.8 31811.7 31923.2 31933.8 5047.8 5076.3 5081.8 5093.9 5118.2 196531.0 196945.0 197194.0 198009.0 198056.0 48105.0 48159.8 48215.3 48267.5 48382.8 50243.2 50419.5 50606.7 50702.7 50757.0 15942.8 16080.8 16182.8 16205.3 16233.2 13257.9 13304.1 13317.5 13329.4 13358.1 14112.2 14218.4 14288.4 14351.0 14491.5 5580.7 5683.9 5842.4 5905.9 5924.4 987.1 997.3 1001.2 1012.9 1013.7 23256.4 28449.9 28755.3 29005.3 29719.3 1046.2 1058.6 1077.4 1081.7 1084.2 12455.4 12465.1 12489.7 12540.6 12597.6 245288.0 247363.0 247592.0 248178.0 248497.0 51149.2 51199.7 51238.0 51273.5 51476.2 1442.3 1468.6 1491.4 1491.9 1501.6 22290.9 22647.4 22780.3 22808.9 22833.0 37490.0 37596.4 37649.8 37659.8 37673.6 217804.0 218572.0 218779.0 219238.0 219389.0 33090.0 33134.2 33344.5 33395.8 33417.2 40308.8 41929.4 45849.3 46998.3 47368.0 30444.4 34558.8 36824.6 37480.3 38167.4 37209.0 37344.0 37352.6 37521.6 38241.6 40195.6 40617.0 40900.0 40953.0 41043.4 42881.6 42950.6 43117.4 43153.0 43240.8 23957.9 26269.2 26597.3 26944.7 27187.0 17:25:33 INFO - PID 2999 | 17:25:33 INFO - PID 2999 | [#2] jquery.html Cycles:180 Average:35617.90 Median:23430.82 stddev:84225.40 (359.5%) stddev-sans-first:84420.59 17:25:33 INFO - PID 2999 | Values: 577.8 579.1 584.9 585.9 596.8 22484.4 22841.0 23194.5 23381.8 23479.9 26712.7 27230.2 27236.5 27311.0 27355.7 6583.0 6727.2 6736.3 6738.2 6739.6 5958.9 6507.3 6510.5 6524.7 6536.1 6488.2 6488.7 6497.1 6518.5 6519.1 6458.3 6471.1 6479.5 6480.3 6485.7 6018.1 6057.3 6059.3 6060.3 6091.4 30150.7 30299.5 30886.7 31779.0 31949.4 1918.3 1937.5 1937.9 1943.7 1949.7 19256.3 19843.6 19853.2 19866.6 19873.9 2419.2 2433.5 2465.3 2507.8 2514.7 137518.0 141313.3 141434.3 141593.0 141808.0 15129.2 15455.6 15555.0 15602.4 15899.9 23348.5 23881.6 24217.2 24314.4 24329.4 10524.4 10556.1 10628.3 10767.7 10877.4 9818.2 9820.5 9838.3 9899.3 10067.9 9561.7 9675.4 9761.1 9797.5 9863.0 2759.5 2810.4 2859.7 2881.5 2893.8 928.5 941.8 949.3 966.4 970.5 20136.2 20364.9 20372.4 20759.4 20875.2 1007.1 1020.6 1022.4 1041.7 1042.5 10941.9 11112.4 11227.2 11241.8 11282.6 479543.0 492612.0 501405.0 501568.0 522997.0 117802.4 118248.0 119091.4 120771.8 122624.4 1201.1 1206.1 1226.9 1232.8 1235.6 17466.7 17484.7 17734.6 17845.1 18557.1 54264.7 54756.0 54790.2 58355.7 58836.7 70121.0 71977.6 72337.0 72397.3 72518.0 14972.2 15220.4 15458.5 15543.6 15554.7 24073.0 24073.5 24502.4 24682.0 24854.3 18733.0 18859.8 19124.3 19185.3 19421.2 16896.5 17240.6 17347.1 17765.7 17818.7 19470.8 19500.8 19895.9 19898.8 20964.0 15066.6 15111.0 15173.5 15250.5 15273.4 18997.3 19086.3 19153.4 19448.8 19456.5 17:25:33 INFO - PID 2999 | 17:25:33 INFO - PID 2999 | [#3] mootools.html Cycles:180 Average:8678.93 Median:2634.17 stddev:5901.05 (224.0%) stddev-sans-first:5892.23 17:25:33 INFO - PID 2999 | Values: 1395.7 1450.4 1466.1 1467.2 1472.5 13767.4 14267.4 14298.4 14303.1 14307.6 13478.8 14301.9 14380.4 14391.7 14399.1 2705.3 2742.7 2751.2 2757.5 2759.1 2620.9 2631.9 2680.9 2683.2 2685.2 2636.5 2664.2 2690.1 2717.1 2717.5 2616.5 2620.6 2644.5 2650.2 2662.0 2619.3 2624.5 2640.3 2649.9 2655.3 13576.1 13752.0 13807.2 13834.3 13838.2 7304.2 7634.7 7639.2 7639.2 7647.9 4850.4 4919.2 4986.5 5073.3 5083.3 1714.4 1744.7 1744.8 1769.1 1774.9 22739.2 22867.0 22879.7 23069.8 23094.2 6337.9 6457.4 6622.4 6635.6 6686.8 16114.1 16177.0 16182.4 16208.5 16224.4 7354.2 7509.2 7510.4 7510.7 7512.1 5583.4 5864.2 6028.3 6654.3 6868.0 4971.5 5132.5 5164.7 5171.1 5293.6 1440.9 1445.9 1472.5 1499.9 1505.2 914.1 932.7 933.1 936.6 940.9 7178.7 7384.0 7385.7 7415.1 7425.1 681.8 700.2 708.8 728.7 735.8 4771.5 5190.5 5286.2 5334.5 5401.4 18358.0 18465.1 19014.0 19193.7 19203.5 18685.3 18688.8 18800.0 18904.0 18961.6 10148.1 10562.5 10750.8 10788.7 10793.4 8599.3 8655.0 8730.2 8758.1 8764.7 16496.1 16914.2 16959.6 17048.1 17207.0 16624.7 16870.5 17100.7 17223.4 17355.3 11442.7 11530.4 11595.1 11627.8 11646.7 13084.4 13164.0 13179.4 13185.2 13213.9 10782.2 10792.6 10885.8 10908.4 11095.0 10485.9 10617.5 10628.2 10713.3 10935.6 9321.0 9469.5 9579.6 9586.0 9587.6 6930.3 6965.4 7066.5 7077.6 7079.3 7187.4 7241.3 7266.8 7311.0 7317.3 17:25:33 INFO - PID 2999 | 17:25:33 INFO - PID 2999 | [#4] prototype.html Cycles:180 Average:5545.92 Median:6126.69 stddev:1560.99 (25.5%) stddev-sans-first:1518.64 17:25:33 INFO - PID 2999 | Values: 495.4 502.5 509.7 527.1 528.2 6202.7 6232.3 6268.4 6284.4 6312.6 6033.7 6122.6 6130.8 6148.2 6184.1 5013.8 5027.6 5056.2 5086.0 5095.0 4796.8 4984.0 5019.7 5059.9 5062.4 4907.3 4916.3 4955.7 4966.3 4978.4 4907.6 4916.2 4953.1 4955.7 4958.6 4410.6 4422.0 4465.4 4539.0 4544.0 5970.9 6087.0 6096.4 6106.7 6141.7 5653.9 5699.6 5711.5 5722.6 5774.3 6565.8 6570.3 6585.8 6606.8 6607.6 4927.1 4930.6 4953.8 4955.8 4958.9 6715.5 6780.3 6866.2 6901.6 6979.6 4975.9 5007.4 5008.2 5076.7 5088.4 5088.3 5090.1 5091.6 5136.8 5164.0 5673.1 5704.5 5705.1 5736.3 5749.6 6335.5 6508.3 6524.4 6594.9 6646.6 1703.4 1746.5 1746.6 1786.6 1788.3 1201.4 1228.6 1238.4 1250.1 1251.5 5671.3 5675.5 5690.6 5704.3 5783.6 6676.9 6735.5 6790.0 6802.1 6937.9 5754.2 5767.3 5813.8 5834.1 5906.2 3589.5 3597.5 3617.1 3638.7 3647.3 6630.5 6663.4 6672.6 6689.8 6736.6 7032.8 7039.2 7053.8 7065.4 7111.2 6500.2 6534.0 6555.1 6555.4 6600.9 6714.4 6749.8 6758.6 6790.6 6808.5 6594.7 6791.9 6807.3 6813.9 6851.9 6534.6 6552.8 6585.4 6612.1 6686.9 4984.3 5038.1 5043.4 5057.8 5082.3 6471.7 6716.8 6808.2 6860.6 6862.7 6443.3 6448.5 6459.3 6603.7 6683.8 6519.5 6520.5 6544.2 6623.9 6667.7 6347.6 6427.9 6445.6 6527.3 6591.0 6570.9 6591.8 6645.0 6666.8 6691.4 6457.5 6464.4 6472.4 6488.7 6511.9 17:25:33 INFO - PID 2999 | 17:25:33 INFO - PID 2999 | [#5] yui.html Cycles:180 Average:24740.11 Median:20706.43 stddev:33029.54 (159.5%) stddev-sans-first:33073.71 17:25:33 INFO - PID 2999 | Values: 904.9 920.5 922.3 926.0 937.1 18758.2 19855.0 19875.0 19883.7 21054.3 22104.6 22558.7 22602.8 22626.0 22665.8 1031.4 1034.3 1035.9 1050.3 1055.3 1026.9 1047.7 1048.0 1050.7 1059.6 1113.9 1119.4 1120.5 1121.6 1124.4 1101.3 1110.4 1116.8 1119.4 1120.2 815.2 815.8 816.0 820.1 821.8 20310.7 20451.5 20568.9 20575.5 21238.9 21608.7 21840.2 21923.2 22150.4 22299.6 17080.1 17225.5 17449.2 17457.2 17690.7 3610.3 3621.1 3636.9 3636.9 3637.2 129081.4 130654.0 131010.3 132425.0 134296.3 16055.6 16111.7 16868.2 17116.8 17166.3 29670.4 30803.7 30933.5 31543.2 31562.5 7836.6 8191.7 8785.4 8800.1 9205.6 4301.2 4368.1 4373.3 4383.4 4400.3 5312.3 5386.9 5405.0 5446.1 5507.6 1017.0 1031.5 1047.9 1054.0 1057.4 705.1 720.3 720.6 731.4 748.5 11831.3 11839.9 11894.2 11998.8 12239.9 643.5 656.5 714.3 717.7 722.5 5418.6 5556.5 5569.1 5813.9 5950.2 107589.0 107865.5 111381.4 113654.4 114033.0 94553.5 99835.5 101464.0 101543.4 102308.5 86266.6 89144.0 89880.6 90872.5 91057.5 12407.2 12827.5 12832.9 13151.7 13447.1 41068.0 41430.6 41536.6 41930.8 42071.4 71049.3 71918.3 72170.6 74522.0 75063.7 19300.1 20354.8 20671.2 20768.6 20923.0 22509.0 22900.9 22909.8 23031.4 23272.0 19835.7 19936.2 20156.6 20557.6 20785.1 19997.9 20280.9 20339.5 20741.7 20760.5 19572.9 20201.3 20244.4 20388.8 20420.6 12986.4 13843.4 13935.1 13942.5 14038.2 14813.8 15418.6 15453.8 15622.5 15720.1 17:25:33 INFO - PID 2999 | -------- Summary: end -------- 17:25:33 INFO - PID 2999 | 17:25:34 INFO - TEST-INFO | 2999: exit 0 17:25:34 INFO - TEST-OK | dromaeo_css | took 1111714ms 17:25:34 INFO - TEST-START | kraken 17:25:34 INFO - Initialising browser for kraken test... 17:25:34 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:55652/getInfo.html -profile /tmp/tmp1fWM21/profile 17:25:34 INFO - TEST-INFO | started process 3375 (/builds/slave/test/build/application/firefox/firefox http://localhost:55652/getInfo.html) 17:25:39 INFO - TEST-INFO | 3375: exit 0 17:25:39 INFO - Browser initialized. 17:25:39 INFO - Running cycle 1/1 for kraken test... 17:25:40 INFO - TEST-INFO | started process 3567 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1fWM21/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 17:25:40 INFO - PID 3567 | 17:25:40 INFO - PID 3567 | (/builds/slave/test/build/application/firefox/firefox:3621): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 17:25:40 INFO - PID 3567 | 17:25:51 INFO - PID 3567 | RSS: Main: 166342656 17:25:51 INFO - PID 3567 | 17:25:53 INFO - PID 3567 | Cycle 1(1): loaded http://localhost:55652/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55652/tests/kraken/driver.html?testName=audio-beat-detection) 17:25:54 INFO - PID 3567 | RSS: Main: 172355584 17:25:54 INFO - PID 3567 | 17:25:57 INFO - PID 3567 | Cycle 1(1): loaded http://localhost:55652/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55652/tests/kraken/driver.html?testName=audio-dft) 17:25:58 INFO - PID 3567 | RSS: Main: 176529408 17:25:58 INFO - PID 3567 | 17:26:01 INFO - PID 3567 | Cycle 1(1): loaded http://localhost:55652/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55652/tests/kraken/driver.html?testName=audio-fft) 17:26:01 INFO - PID 3567 | RSS: Main: 170405888 17:26:01 INFO - PID 3567 | 17:26:04 INFO - PID 3567 | Cycle 1(1): loaded http://localhost:55652/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55652/tests/kraken/driver.html?testName=audio-oscillator) 17:26:04 INFO - PID 3567 | RSS: Main: 171196416 17:26:04 INFO - PID 3567 | 17:26:07 INFO - PID 3567 | Cycle 1(1): loaded http://localhost:55652/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55652/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:26:07 INFO - PID 3567 | RSS: Main: 171651072 17:26:07 INFO - PID 3567 | 17:26:10 INFO - PID 3567 | Cycle 1(1): loaded http://localhost:55652/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55652/tests/kraken/driver.html?testName=imaging-darkroom) 17:26:11 INFO - PID 3567 | RSS: Main: 172507136 17:26:11 INFO - PID 3567 | 17:26:14 INFO - PID 3567 | Cycle 1(1): loaded http://localhost:55652/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55652/tests/kraken/driver.html?testName=imaging-desaturate) 17:26:15 INFO - PID 3567 | RSS: Main: 172093440 17:26:15 INFO - PID 3567 | 17:26:18 INFO - PID 3567 | Cycle 1(1): loaded http://localhost:55652/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55652/tests/kraken/driver.html?testName=json-parse-financial) 17:26:19 INFO - PID 3567 | RSS: Main: 173203456 17:26:19 INFO - PID 3567 | 17:26:20 INFO - PID 3567 | Cycle 1(1): loaded http://localhost:55652/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55652/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:26:21 INFO - PID 3567 | RSS: Main: 173146112 17:26:21 INFO - PID 3567 | 17:26:23 INFO - PID 3567 | Cycle 1(1): loaded http://localhost:55652/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55652/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:26:23 INFO - PID 3567 | RSS: Main: 173182976 17:26:23 INFO - PID 3567 | 17:26:26 INFO - PID 3567 | Cycle 1(1): loaded http://localhost:55652/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55652/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:26:26 INFO - PID 3567 | RSS: Main: 173486080 17:26:26 INFO - PID 3567 | 17:26:29 INFO - PID 3567 | Cycle 1(1): loaded http://localhost:55652/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55652/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:26:30 INFO - PID 3567 | RSS: Main: 173617152 17:26:30 INFO - PID 3567 | 17:26:33 INFO - PID 3567 | Cycle 1(1): loaded http://localhost:55652/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55652/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:26:33 INFO - PID 3567 | RSS: Main: 174161920 17:26:33 INFO - PID 3567 | 17:26:35 INFO - PID 3567 | Cycle 1(1): loaded http://localhost:55652/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55652/tests/kraken/driver.html?testName=ai-astar) 17:26:35 INFO - PID 3567 | RSS: Main: 175235072 17:26:35 INFO - PID 3567 | 17:26:35 INFO - PID 3567 | __start_tp_report 17:26:35 INFO - PID 3567 | _x_x_mozilla_page_load 17:26:35 INFO - PID 3567 | _x_x_mozilla_page_load_details 17:26:35 INFO - PID 3567 | |i|pagename|runs| 17:26:35 INFO - PID 3567 | |0;ai-astar;99;107;101;114;114;110;110;103;107;107 17:26:35 INFO - PID 3567 | |1;audio-beat-detection;154;127;161;185;123;148;149;118;174;118 17:26:35 INFO - PID 3567 | |2;audio-dft;164;163;169;165;172;166;172;171;164;166 17:26:35 INFO - PID 3567 | |3;audio-fft;78;76;76;167;83;81;75;81;99;76 17:26:35 INFO - PID 3567 | |4;audio-oscillator;79;83;134;78;80;78;133;78;77;134 17:26:35 INFO - PID 3567 | |5;imaging-gaussian-blur;117;115;113;114;114;114;122;115;116;113 17:26:35 INFO - PID 3567 | |6;imaging-darkroom;150;149;151;149;149;149;152;150;150;150 17:26:35 INFO - PID 3567 | |7;imaging-desaturate;94;94;94;99;97;93;95;104;94;97 17:26:35 INFO - PID 3567 | |8;json-parse-financial;58;54;53;58;54;54;55;56;53;54 17:26:35 INFO - PID 3567 | |9;json-stringify-tinderbox;54;54;54;55;53;53;58;54;54;54 17:26:35 INFO - PID 3567 | |10;stanford-crypto-aes;81;79;77;80;78;77;84;86;78;86 17:26:35 INFO - PID 3567 | |11;stanford-crypto-ccm;120;122;124;121;127;127;127;123;124;170 17:26:35 INFO - PID 3567 | |12;stanford-crypto-pbkdf2;179;188;187;175;180;189;175;179;184;177 17:26:35 INFO - PID 3567 | |13;stanford-crypto-sha256-iterative;74;69;82;68;71;67;72;66;68;75 17:26:35 INFO - PID 3567 | __end_tp_report 17:26:35 INFO - PID 3567 | __start_cc_report 17:26:35 INFO - PID 3567 | _x_x_mozilla_cycle_collect,945 17:26:35 INFO - PID 3567 | __end_cc_report 17:26:35 INFO - PID 3567 | __startTimestamp1503015995963__endTimestamp 17:26:35 INFO - PID 3567 | 17:26:35 INFO - PID 3567 | ------- Summary: start ------- 17:26:35 INFO - PID 3567 | Number of tests: 14 17:26:35 INFO - PID 3567 | 17:26:35 INFO - PID 3567 | [#0] ai-astar Cycles:10 Average:107.20 Median:110.00 stddev:5.07 (4.6%) stddev-sans-first:4.43 17:26:35 INFO - PID 3567 | Values: 99.0 107.0 101.0 114.0 114.0 110.0 110.0 103.0 107.0 107.0 17:26:35 INFO - PID 3567 | 17:26:35 INFO - PID 3567 | [#1] audio-beat-detection Cycles:10 Average:145.70 Median:151.50 stddev:23.72 (15.7%) stddev-sans-first:24.97 17:26:35 INFO - PID 3567 | Values: 154.0 127.0 161.0 185.0 123.0 148.0 149.0 118.0 174.0 118.0 17:26:35 INFO - PID 3567 | 17:26:35 INFO - PID 3567 | [#2] audio-dft Cycles:10 Average:167.20 Median:167.50 stddev:3.49 (2.1%) stddev-sans-first:3.50 17:26:35 INFO - PID 3567 | Values: 164.0 163.0 169.0 165.0 172.0 166.0 172.0 171.0 164.0 166.0 17:26:35 INFO - PID 3567 | 17:26:35 INFO - PID 3567 | [#3] audio-fft Cycles:10 Average:89.20 Median:79.50 stddev:28.23 (35.5%) stddev-sans-first:29.65 17:26:35 INFO - PID 3567 | Values: 78.0 76.0 76.0 167.0 83.0 81.0 75.0 81.0 99.0 76.0 17:26:35 INFO - PID 3567 | 17:26:35 INFO - PID 3567 | [#4] audio-oscillator Cycles:10 Average:95.40 Median:78.00 stddev:26.46 (33.9%) stddev-sans-first:27.39 17:26:35 INFO - PID 3567 | Values: 79.0 83.0 134.0 78.0 80.0 78.0 133.0 78.0 77.0 134.0 17:26:35 INFO - PID 3567 | 17:26:35 INFO - PID 3567 | [#5] imaging-gaussian-blur Cycles:10 Average:115.30 Median:115.00 stddev:2.67 (2.3%) stddev-sans-first:2.76 17:26:35 INFO - PID 3567 | Values: 117.0 115.0 113.0 114.0 114.0 114.0 122.0 115.0 116.0 113.0 17:26:35 INFO - PID 3567 | 17:26:35 INFO - PID 3567 | [#6] imaging-darkroom Cycles:10 Average:149.90 Median:150.00 stddev:0.99 (0.7%) stddev-sans-first:1.05 17:26:35 INFO - PID 3567 | Values: 150.0 149.0 151.0 149.0 149.0 149.0 152.0 150.0 150.0 150.0 17:26:35 INFO - PID 3567 | 17:26:35 INFO - PID 3567 | [#7] imaging-desaturate Cycles:10 Average:96.10 Median:94.50 stddev:3.35 (3.5%) stddev-sans-first:3.46 17:26:35 INFO - PID 3567 | Values: 94.0 94.0 94.0 99.0 97.0 93.0 95.0 104.0 94.0 97.0 17:26:35 INFO - PID 3567 | 17:26:35 INFO - PID 3567 | [#8] json-parse-financial Cycles:10 Average:54.90 Median:54.50 stddev:1.85 (3.4%) stddev-sans-first:1.59 17:26:35 INFO - PID 3567 | Values: 58.0 54.0 53.0 58.0 54.0 54.0 55.0 56.0 53.0 54.0 17:26:35 INFO - PID 3567 | 17:26:35 INFO - PID 3567 | [#9] json-stringify-tinderbox Cycles:10 Average:54.30 Median:54.00 stddev:1.42 (2.6%) stddev-sans-first:1.50 17:26:35 INFO - PID 3567 | Values: 54.0 54.0 54.0 55.0 53.0 53.0 58.0 54.0 54.0 54.0 17:26:35 INFO - PID 3567 | 17:26:35 INFO - PID 3567 | [#10] stanford-crypto-aes Cycles:10 Average:80.60 Median:80.50 stddev:3.53 (4.4%) stddev-sans-first:3.75 17:26:35 INFO - PID 3567 | Values: 81.0 79.0 77.0 80.0 78.0 77.0 84.0 86.0 78.0 86.0 17:26:35 INFO - PID 3567 | 17:26:35 INFO - PID 3567 | [#11] stanford-crypto-ccm Cycles:10 Average:128.50 Median:125.50 stddev:14.80 (11.8%) stddev-sans-first:15.37 17:26:35 INFO - PID 3567 | Values: 120.0 122.0 124.0 121.0 127.0 127.0 127.0 123.0 124.0 170.0 17:26:35 INFO - PID 3567 | 17:26:35 INFO - PID 3567 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:181.30 Median:182.00 stddev:5.31 (2.9%) stddev-sans-first:5.57 17:26:35 INFO - PID 3567 | Values: 179.0 188.0 187.0 175.0 180.0 189.0 175.0 179.0 184.0 177.0 17:26:35 INFO - PID 3567 | 17:26:35 INFO - PID 3567 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.20 Median:71.50 stddev:4.83 (6.7%) stddev-sans-first:5.01 17:26:35 INFO - PID 3567 | Values: 74.0 69.0 82.0 68.0 71.0 67.0 72.0 66.0 68.0 75.0 17:26:35 INFO - PID 3567 | -------- Summary: end -------- 17:26:35 INFO - PID 3567 | 17:26:36 INFO - PID 3567 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 17:26:36 INFO - TEST-INFO | 3567: exit 0 17:26:36 INFO - TEST-OK | kraken | took 62376ms 17:26:36 INFO - SUITE-END | took 1174s 17:26:37 INFO - Completed test suite (00:19:34) 17:26:37 INFO - javascript benchmark 17:26:37 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8605.842764079514, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3147.4334619768447, 3152.0701393089034, 3176.6664500227475, 3185.10816971248, 3190.34597907429, 6073.665948372838, 6241.875162496747, 6262.749490020394, 6291.307956124822, 6325.746970121189, 6023.337432882379, 6191.4737247333915, 6191.845203869905, 6202.193714817067, 6223.159873417098, 5597.328320601534, 5604.859878503029, 5650.886982260352, 5672.829815105553, 5784.161296611988, 5709.0580054290995, 5769.740361683714, 5785.190073389729, 5793.507551858097, 5810.970945145268, 5562.499375056264, 5679.687617181074, 5686.914696279559, 5734.483896449339, 5747.741351639165, 5670.092785154397, 5709.714514274269, 5723.456271654228, 5732.111522713986, 5772.595918285721, 5639.069553523664, 5642.4357564243655, 5716.57125715573, 5720.370759216483, 5733.799317023884, 6074.301455332605, 6077.787277445268, 6104.450599446027, 6113.663748493831, 6254.374562543755, 6555.573887697332, 6584.637844918528, 6589.835254118685, 6620.9006864897065, 6668.199816022108, 6747.257801641816, 6764.255931847493, 6775.898361524581, 6784.694688739019, 6794.0827988221945, 6173.290071641729, 6259.217597800275, 6273.027680709497, 6283.246010478726, 6294.905576416358, 6754.527183097136, 6864.691088901011, 6871.690773915186, 6963.059986901805, 6996.230414654384, 6392.872142557216, 6486.708098135595, 6497.18785151856, 6617.834554136185, 6626.138601981712, 6687.331266873273, 6700.262971073178, 6717.865642687118, 6742.93257067423, 6756.594604323756, 6615.801525954229, 6633.701483433257, 6701.39687428124, 6704.296048914891, 6713.765018224339, 6664.8000559983275, 6685.364890335411, 6747.865042699119, 6761.053452516651, 6766.120404347404, 5025.447200807908, 5054.9241761373605, 5087.287779710843, 5100.005498927673, 5104.821331253388, 4392.407025051577, 4421.602055814992, 4428.667849911205, 4429.424174857248, 4451.3323001550025, 5675.318961724537, 5744.253247077853, 5759.884802304015, 5780.508656764138, 5791.88416231673, 6603.504737144734, 6650.833729156713, 6677.76627818024, 6735.4274886635185, 6771.796846094625, 5652.18043383707, 5717.514011309086, 5725.656460612377, 5818.76724930998, 5821.446962538552, 5835.358110607915, 5842.561807864342, 5921.378255283219, 5942.197803296586, 5944.554158438134, 6473.708683109177, 6489.415952564197, 6512.316206798313, 6521.152250207538, 6544.247411547733, 6691.966540167268, 6697.598144111369, 6776.390124888882, 6788.1175447191545, 6807.115075040411, 6340.080688300263, 6402.327755585597, 6418.326075762165, 6419.197600299963, 6525.0, 6511.706973186313, 6572.34276572339, 6583.868322633616, 6603.174603174603, 6605.240397354366, 6605.735770569124, 6674.332566743286, 6689.364510371507, 6692.196936367667, 6694.765683201259, 6404.647744373918, 6492.5455218134275, 6493.4155925965, 6494.0258961156205, 6496.317886621837, 6388.425041746265, 6389.584676995981, 6480.546361754632, 6483.319251478527, 6488.091667166695, 6295.842603934938, 6335.429811317003, 6374.936250637435, 6387.329330420424, 6407.743690252338, 6388.488920886411, 6458.935410646021, 6460.547761656639, 6476.740930362733, 6577.2436169841085, 6368.904466432915, 6392.264889537577, 6442.033694945608, 6449.935500644933, 6450.774222902176], "value": 6066.053037145616, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [786.1470304719379, 841.2092632925049, 862.6075135813202, 866.1252135343301, 1158.7624536969922, 39684.603153968485, 40514.59485405145, 40684.186316273655, 40685.389719154235, 40746.59253407473, 41560.58439415605, 41938.58061419385, 41945.58054419455, 42032.0, 42038.789806050925, 7721.420893432987, 7796.103448103484, 7829.686812527492, 7837.529748215097, 7848.6860525579195, 7648.808779780522, 7757.26306000929, 7805.531668099932, 7809.492382995116, 7810.2189781021725, 7303.488755787097, 7818.413618978571, 7851.5681637509915, 7853.64658590362, 7894.4868583542175, 7781.494202876823, 7845.0, 7846.097698764658, 7849.175836537167, 7849.215078492162, 7661.885071723928, 7706.152323244439, 7749.031371078615, 7755.0, 7757.146713861471, 37459.06352341186, 37650.623493764986, 37719.0, 38340.0, 38739.0, 3603.891883243507, 3644.69020133289, 3646.4530320452145, 3646.74472786905, 3648.343298206322, 31774.205644859063, 31800.840995795104, 31811.681883181103, 31923.201919951956, 31933.840330798197, 5047.772850221749, 5076.289319495274, 5081.771320290596, 5093.872653183663, 5118.206677964884, 196531.0, 196945.0, 197194.0, 198009.0, 198055.99999999854, 48105.0, 48159.75920120377, 48215.27677084847, 48267.51732482701, 48382.758086209345, 50243.24635130476, 50419.495805042214, 50606.74696626493, 50702.74648626733, 50757.0, 15942.760858587131, 16080.758788618181, 16182.838171618369, 16205.270762815702, 16233.188340582923, 13257.933710331386, 13304.13523120994, 13317.533886314126, 13329.400176992058, 13358.131721438076, 14112.223827689575, 14218.360173792204, 14288.35702393374, 14351.0, 14491.492797752238, 5580.693061881554, 5683.8863222736145, 5842.444967728059, 5905.911411328833, 5924.407559244041, 987.1411871671548, 997.3467378866853, 1001.2040427859869, 1012.8885822559513, 1013.6502906497246, 23256.4185895354, 28449.85775071153, 28755.28111797222, 29005.274868128465, 29719.25701857471, 1046.1526163807341, 1058.5977328615077, 1077.3589714120242, 1081.729567608098, 1084.2410312781085, 12455.439505222286, 12465.12744107922, 12489.687757805947, 12540.557835848995, 12597.559085431965, 245288.0, 247363.0, 247592.0, 248178.0, 248497.0, 51149.23276150861, 51199.7440012805, 51238.0, 51273.487265126874, 51476.22785658218, 1442.278860569715, 1468.5667728020046, 1491.358715752237, 1491.9104853708811, 1501.6020754500066, 22290.88854555717, 22647.433814154778, 22780.316590502312, 22808.885955570116, 22833.0, 37490.0, 37596.436053458674, 37649.81175094107, 37659.81170094132, 37673.62326376811, 217804.0, 218572.0, 218779.0, 219238.0, 219389.0, 33090.0, 33134.17164570905, 33344.49983250205, 33395.83302083474, 33417.16457088592, 40308.798456008706, 41929.37105943474, 45849.312260315455, 46998.29502557396, 47368.0, 30444.391112178077, 34558.82720586381, 36824.63175368319, 37480.250394992494, 38167.42748858825, 37209.0, 37344.0, 37352.62647373491, 37521.62478375181, 38241.617583823805, 40195.598044019185, 40617.0, 40900.0, 40953.0, 41043.38434923419, 42881.57118428901, 42950.570494295906, 43117.35323970205, 43153.0, 43240.78379608082, 23957.880210598836, 26269.21192364232, 26597.335066622716, 26944.730552694222, 27187.0], "value": 17777.254998472916, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [577.8237637520557, 579.1457600039939, 584.8742520358128, 585.9443352881476, 596.7791916990712, 22484.43788905278, 22841.0, 23194.536109277804, 23381.76618233817, 23479.882600586974, 26712.732872671266, 27230.183094507145, 27236.45527089457, 27311.0, 27355.726442735566, 6582.967085164568, 6727.192736871582, 6736.29268926763, 6738.225104113017, 6739.561928474658, 5958.940410595904, 6507.31673174317, 6510.5442619016685, 6524.706388212542, 6536.052272420497, 6488.188976377953, 6488.740450381979, 6497.05792660064, 6518.543701940866, 6519.087327774116, 6458.321876203002, 6471.126397936266, 6479.481641468671, 6480.254770701383, 6485.70814313357, 6018.067199584071, 6057.30341010785, 6059.272887253558, 6060.272767267912, 6091.360407157274, 30150.69849301501, 30299.545506817416, 30886.691133088607, 31779.0, 31949.361012779613, 1918.2998205654976, 1937.5253062999514, 1937.883726976386, 1943.7375954246138, 1949.707543868417, 19256.326028588934, 19843.603127937506, 19853.205871765113, 19866.60266794656, 19873.9006304969, 2419.201663451057, 2433.5497932882295, 2465.2604218734486, 2507.8244522883406, 2514.6730924979634, 137518.0, 141313.29343353218, 141434.2928285352, 141593.0, 141808.0, 15129.167895765619, 15455.613609659624, 15555.0, 15602.375904963901, 15899.920500397424, 23348.533029339316, 23881.641775373384, 24217.152399665927, 24314.392140196636, 24329.39176520601, 10524.36853788775, 10556.102731267774, 10628.309159904582, 10767.730806729895, 10877.401742904058, 9818.165455936183, 9820.45987470696, 9838.262130340254, 9899.257555683353, 10067.949660251652, 9561.713148605413, 9675.419474831533, 9761.121499064977, 9797.461139637388, 9863.04108767367, 2759.530879750447, 2810.423863108099, 2859.6711378191776, 2881.4525240204293, 2893.7540309073543, 928.4986107502008, 941.7598512379436, 949.3354651743807, 966.415318732157, 970.5050424283667, 20136.19455221775, 20364.898175509028, 20372.388828335173, 20759.377218683465, 20875.164993400092, 1007.1036777268237, 1020.5968642386364, 1022.3763504262394, 1041.7499800047933, 1042.5308611125024, 10941.890581094247, 11112.444377781241, 11227.21409501327, 11241.83137252942, 11282.605108821152, 479543.0, 492612.0, 501405.0, 501568.0, 522997.0, 117802.41098794452, 118248.0, 119091.40454297673, 120771.79228207606, 122624.38687806504, 1201.1274687932669, 1206.1135065726685, 1226.926384416938, 1232.8335674683804, 1235.6293112066344, 17466.73799893028, 17484.650306994045, 17734.556636083686, 17845.10774461246, 18557.072146392355, 54264.72867635637, 54756.0, 54790.17814732862, 58355.70822145862, 58836.70581647065, 70121.0, 71977.6401117991, 72337.0, 72397.27602723906, 72518.0, 14972.176530290939, 15220.391184352944, 15458.458953937008, 15543.611409714847, 15554.688906222038, 24073.0, 24073.51852962966, 24502.38744031342, 24682.0, 24854.254372368134, 18733.0, 18859.811401885807, 19124.33064842724, 19185.32851350196, 19421.2231510738, 16896.493105206864, 17240.568985775455, 17347.132643368033, 17765.733513997042, 17818.732719008967, 19470.805291947465, 19500.804991950467, 19895.900520497304, 19898.801011989694, 20964.0, 15066.623334416727, 15111.0, 15173.544793656209, 15250.542483725507, 15273.389064437299, 18997.335093271668, 19086.331978381244, 19153.425397238105, 19448.805511944698, 19456.513587160433], "value": 12261.537263444494, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1395.7348103860265, 1450.4125829039235, 1466.061720498881, 1467.2443691498877, 1472.5287907869485, 13767.380467878944, 14267.3579688914, 14298.356573954172, 14303.070300430478, 14307.570772876805, 13478.797818032737, 14301.928490357559, 14380.352884120213, 14391.712165756679, 14399.136051836897, 2705.3371923878626, 2742.698303186648, 2751.2021513760988, 2757.5036493431276, 2759.11708253359, 2620.9213723588227, 2631.855247961371, 2680.919572412831, 2683.1950414875555, 2685.194441667502, 2636.4858852523766, 2664.214056853233, 2690.1391554702504, 2717.1305182341657, 2717.4565086982584, 2616.4505453854713, 2620.59380795976, 2644.4975454663554, 2650.218185635242, 2661.9884443911383, 2619.345163709073, 2624.5407053765707, 2640.339915021245, 2649.9205023849318, 2655.2830735701446, 13576.117552359065, 13752.0, 13807.17156970585, 13834.308284585832, 13838.238896860668, 7304.233055529199, 7634.732784352521, 7639.197884222132, 7639.197884222132, 7647.885281720779, 4850.442199147108, 4919.163742163841, 4986.4514903360605, 5073.315102461194, 5083.3391659084455, 1714.41709818661, 1744.6685129825294, 1744.834240747127, 1769.1331247688668, 1774.8757586968918, 22739.20412785561, 22866.970986305823, 22879.656805147937, 23069.76930230693, 23094.191703290304, 6337.8732425352155, 6457.3865482779065, 6622.437092847065, 6635.635040072746, 6686.7993960181275, 16114.113723745071, 16177.0, 16182.352705891632, 16208.51374458768, 16224.35102595883, 7354.191038985814, 7509.173990861001, 7510.361619262315, 7510.699572017058, 7512.060992375953, 5583.4137415571595, 5864.179014937912, 6028.33688294296, 6654.334566543307, 6868.038474613558, 4971.502849715, 5132.486751324912, 5164.690118592896, 5171.120909445328, 5293.550048245866, 1440.9481078812526, 1445.869871711551, 1472.4919902633574, 1499.9400023998917, 1505.1871989125968, 914.1315750037359, 932.7341707613298, 933.1135421349745, 936.5551363102608, 940.8541676040225, 7178.748743793943, 7383.963080184565, 7385.704571817175, 7415.1101867776215, 7425.146108197627, 681.8499930015389, 700.198272977438, 708.7661071846278, 728.6757392960188, 735.8086897406713, 4771.498992605726, 5190.480951904855, 5286.15421532553, 5334.51989320963, 5401.378841433207, 18358.0, 18465.076746162908, 19014.049297535068, 19193.712094318595, 19203.519912002314, 18685.252589896252, 18688.813111868978, 18800.0, 18904.0, 18961.620767584573, 10148.137408320375, 10562.524686388977, 10750.8387374191, 10788.730281743019, 10793.352398856094, 8599.312055035458, 8655.0, 8730.214280714767, 8758.12418758119, 8764.693235736719, 16496.092714900795, 16914.238859251116, 16959.576010599834, 17048.147592620073, 17206.999999999498, 16624.667506650043, 16870.493885183463, 17100.65798684044, 17223.3971810986, 17355.30578776885, 11442.713932151762, 11530.365829879102, 11595.072394208612, 11627.767444651228, 11646.65060048166, 13084.411201496147, 13164.0, 13179.40692668813, 13185.208887466782, 13213.933930330288, 10782.1913356497, 10792.56829726802, 10885.782284354427, 10908.400037997986, 11095.0, 10485.895141048797, 10617.469126543796, 10628.202884783517, 10713.303635263683, 10935.617253396093, 9321.0, 9469.47917864524, 9579.568919398504, 9585.952070239604, 9587.568559414703, 6930.341617546325, 6965.44276457872, 7066.4700147490175, 7077.610731409822, 7079.29207079288, 7187.389071928945, 7241.275872412716, 7266.818329541804, 7311.0, 7317.304856038668], "value": 6311.157298189419, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [495.41045190510914, 502.45232696360983, 509.68399592252797, 527.0644605824658, 528.1575886461096, 6202.7208775605095, 6232.3456037116075, 6268.37316268373, 6284.434400903918, 6312.589681670694, 6033.668148251844, 6122.602030867991, 6130.785422510213, 6148.231471066117, 6184.103305020781, 5013.799448022075, 5027.597792176635, 5056.191009438472, 5086.0, 5095.0, 4796.83211087612, 4983.950160498385, 5019.673721208128, 5059.949400506003, 5062.417821950486, 4907.2884431757375, 4916.262560615918, 4955.727434991074, 4966.255061740731, 4978.377702787152, 4907.582855457273, 4916.237983112624, 4953.133201689726, 4955.702657840541, 4958.553730164284, 4410.6030457259, 4421.977890110561, 4465.441819772528, 4539.0, 4543.954560454386, 5970.910436343458, 6086.960868109189, 6096.359882212349, 6106.72519736613, 6141.744875216143, 5653.8586535336535, 5699.601027928046, 5711.514521265697, 5722.62802917809, 5774.2782152230975, 6565.848392771449, 6570.310117437648, 6585.80242592723, 6606.8017959461295, 6607.636579988099, 4927.088488629579, 4930.556249937487, 4953.777080031371, 4955.752212389366, 4958.851234462972, 6715.5488246790055, 6780.254172041072, 6866.210385805646, 6901.585904845725, 6979.616121113337, 4975.850724478271, 5007.372603903673, 5008.223725322581, 5076.695398276115, 5088.389393272757, 5088.262201980692, 5090.134677104901, 5091.592672586185, 5136.8202112925865, 5164.04465173944, 5673.120666296648, 5704.515116215085, 5705.145827606045, 5736.311642602915, 5749.568782341257, 6335.461485773669, 6508.349165083454, 6524.380183882524, 6594.86810263792, 6646.567973081831, 1703.4073141612632, 1746.4585978346754, 1746.6244757377224, 1786.5980154465142, 1788.2578729827237, 1201.3512703140382, 1228.6007047709352, 1238.4303220518482, 1250.1124201816813, 1251.4806355362423, 5671.319441666944, 5675.5459563234845, 5690.630109042899, 5704.286964129484, 5783.566232532577, 6676.899846502306, 6735.5002422662365, 6790.0, 6802.14973128359, 6937.861242775217, 5754.223179870663, 5767.336756272998, 5813.767449302065, 5834.095715164071, 5906.202662640574, 3589.4795254687924, 3597.5323207982797, 3617.077645200457, 3638.653068770628, 3647.325244829715, 6630.53586248958, 6663.400293973566, 6672.566283191577, 6689.799306020827, 6736.562123461959, 7032.753853615099, 7039.225685174627, 7053.788386348418, 7065.399441047569, 7111.182214045451, 6500.154979852683, 6534.0, 6555.115059466911, 6555.410013098844, 6600.86798264032, 6714.3957043866285, 6749.763758268437, 6758.594484330956, 6790.626515541495, 6808.523403361717, 6594.736210551524, 6791.864162716817, 6807.311112110788, 6813.921753864921, 6851.862962740817, 6534.640594767143, 6552.770653027121, 6585.440237579859, 6612.140421745143, 6686.866262674622, 4984.277279794482, 5038.118329292286, 5043.42000669913, 5057.848264552069, 5082.33929589151, 6471.741130354733, 6716.798496044931, 6808.217055038734, 6860.5540639858245, 6862.691178897061, 6443.2590252119735, 6448.516361272829, 6459.321771213955, 6603.735850565923, 6683.799486015428, 6519.4784417245555, 6520.478361731145, 6544.247411547733, 6623.933760662332, 6667.733290668513, 6347.619142851444, 6427.903581446376, 6445.613263204223, 6527.3472652734345, 6590.978398348264, 6570.911671514381, 6591.835204119743, 6645.036469711961, 6666.766663166766, 6691.364320389555, 6457.4511166551365, 6464.41820236181, 6472.449841763315, 6488.6755662215755, 6511.902321465087], "value": 5086.026674476852, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [904.895936967249, 920.4707293306351, 922.2621902478018, 926.0230456868006, 937.0863408177026, 18758.2496700132, 19855.0, 19875.0, 19883.701744473827, 21054.263100791475, 22104.557908841813, 22558.661620075673, 22602.77397226027, 22626.0, 22665.773342266573, 1031.365710088294, 1034.312182398704, 1035.927485076045, 1050.2700623066933, 1055.3298655353829, 1026.856240126383, 1047.711879233213, 1048.0305717211586, 1050.679542739464, 1059.607945060325, 1113.899749022588, 1119.3787447966376, 1120.5069769301522, 1121.5850135449896, 1124.3647339253296, 1101.3281898042187, 1110.4392281897672, 1116.8157254053071, 1119.356370087203, 1120.2158489057651, 815.1807433529324, 815.7675062607187, 816.0085496122181, 820.0774129104757, 821.7822277096574, 20310.695339569917, 20451.48871278215, 20568.897155514125, 20575.485612859648, 21238.89380553103, 21608.675869861963, 21840.23559175421, 21923.23268685604, 22150.446238844157, 22299.55400891989, 17080.14599270044, 17225.483235502954, 17449.21478533469, 17457.21442535089, 17690.734638980426, 3610.295992281506, 3621.112827357288, 3636.909077273063, 3636.9272614547826, 3637.199816040467, 129081.35459322737, 130654.0, 131010.34494827465, 132425.0, 134296.32851835777, 16055.598610034609, 16111.677766444605, 16868.24092915822, 17116.828831711522, 17166.313347465963, 29670.406591868043, 30803.69196308053, 30933.535996960065, 31543.21141971469, 31562.526562101586, 7836.608169591497, 8191.672333106728, 8785.428947118417, 8800.075992020873, 9205.585748641328, 4301.161273551627, 4368.060866913629, 4373.278409062469, 4383.408239887638, 4400.295952647625, 5312.309399778082, 5386.946130538723, 5405.0, 5446.101393270145, 5507.642003269774, 1016.9898301017043, 1031.4791030529534, 1047.863777708893, 1054.0408228512017, 1057.3919996002176, 705.108038331511, 720.3157000849214, 720.6252748570714, 731.4112139727571, 748.4835463530255, 11831.349275789915, 11839.88160118405, 11894.226875253082, 11998.820017699742, 12239.938800305941, 643.4723526708148, 656.4977791989132, 714.2857142857143, 717.7021536062475, 722.458156382713, 5418.620696551204, 5556.527695145877, 5569.108942569251, 5813.912791308134, 5950.166976623276, 107589.0, 107865.46067269614, 111381.44309278401, 113654.43172784083, 114033.0, 94553.5272323634, 99835.50082249542, 101464.0, 101543.44597939037, 102308.48845755872, 86266.56866715626, 89144.0, 89880.55059724659, 90872.5456372714, 91057.54471227733, 12407.193532420364, 12827.486900524247, 12832.935835320764, 13151.671208219872, 13447.125936814076, 41068.0, 41430.585694142675, 41536.584634153274, 41930.790346048074, 42071.3689294667, 71049.28950710427, 71918.28081719116, 72170.63914680394, 74522.0, 75063.74808755745, 19300.131494082518, 20354.79645203529, 20671.17315307371, 20768.584628307046, 20923.0, 22509.0, 22900.885495572416, 22909.770902290762, 23031.424214394774, 23272.0, 19835.702464462756, 19936.20255189776, 20156.59686806285, 20557.58884822265, 20785.06467208949, 19997.900010499856, 20280.89859550693, 20339.491512712302, 20741.688874667194, 20760.48098797542, 19572.902135489232, 20201.292954746514, 20244.392668219978, 20388.79611203869, 20420.591588168452, 12986.35068246565, 13843.4462621494, 13935.09421887574, 13942.512012079529, 14038.227897465737, 14813.777793332893, 15418.614534636723, 15453.768193477332, 15622.453214137451, 15720.135392553062], "value": 9570.370410448017, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1536.7999999999997, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 107.0, 101.0, 114.0, 114.0, 110.0, 110.0, 103.0, 107.0, 107.0], "value": 107.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 127.0, 161.0, 185.0, 123.0, 148.0, 149.0, 118.0, 174.0, 118.0], "value": 145.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 163.0, 169.0, 165.0, 172.0, 166.0, 172.0, 171.0, 164.0, 166.0], "value": 167.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 76.0, 76.0, 167.0, 83.0, 81.0, 75.0, 81.0, 99.0, 76.0], "value": 89.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 83.0, 134.0, 78.0, 80.0, 78.0, 133.0, 78.0, 77.0, 134.0], "value": 95.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 115.0, 113.0, 114.0, 114.0, 114.0, 122.0, 115.0, 116.0, 113.0], "value": 115.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 149.0, 151.0, 149.0, 149.0, 149.0, 152.0, 150.0, 150.0, 150.0], "value": 149.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 99.0, 97.0, 93.0, 95.0, 104.0, 94.0, 97.0], "value": 96.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 54.0, 53.0, 58.0, 54.0, 54.0, 55.0, 56.0, 53.0, 54.0], "value": 54.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 54.0, 54.0, 55.0, 53.0, 53.0, 58.0, 54.0, 54.0, 54.0], "value": 54.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 79.0, 77.0, 80.0, 78.0, 77.0, 84.0, 86.0, 78.0, 86.0], "value": 80.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [120.0, 122.0, 124.0, 121.0, 127.0, 127.0, 127.0, 123.0, 124.0, 170.0], "value": 128.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [179.0, 188.0, 187.0, 175.0, 180.0, 189.0, 175.0, 179.0, 184.0, 177.0], "value": 181.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 69.0, 82.0, 68.0, 71.0, 67.0, 72.0, 66.0, 68.0, 75.0], "value": 71.2, "unit": "score"}]}]} 17:26:37 INFO - Return code: 0 17:26:37 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 17:26:37 INFO - # TBPL SUCCESS # 17:26:37 INFO - Running post-action listener: _package_coverage_data 17:26:37 INFO - Running post-action listener: _resource_record_post_action 17:26:37 INFO - [mozharness: 2017-08-18 00:26:37.226280Z] Finished run-tests step (success) 17:26:37 INFO - Running post-run listener: _resource_record_post_run 17:26:37 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 4096; Write bytes: 432640000; Read time: 12; Write time: 288040 17:26:37 INFO - TinderboxPrint: CPU usage
13.1% 17:26:37 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 17:26:37 INFO - TinderboxPrint: I/O write bytes / time
432,640,000 / 288,040 17:26:37 INFO - TinderboxPrint: CPU idle
8,262.6 (86.9%) 17:26:37 INFO - TinderboxPrint: CPU user
1,201.1 (12.6%) 17:26:37 INFO - TinderboxPrint: Swap in / out
0 / 0 17:26:37 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 107876352; Read time: 0; Write time: 92544 17:26:37 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:37 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 0; Write bytes: 324763648; Read time: 0; Write time: 195496 17:26:37 INFO - Running post-run listener: _upload_blobber_files 17:26:37 INFO - Blob upload gear active. 17:26:37 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:26:37 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:37 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:37 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:38 INFO - (blobuploader) - INFO - Open directory for files ... 17:26:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 17:26:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:26:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:26:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 17:26:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:26:39 INFO - (blobuploader) - INFO - Done attempting. 17:26:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 17:26:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:26:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:26:44 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 17:26:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:26:44 INFO - (blobuploader) - INFO - Done attempting. 17:26:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 17:26:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:26:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:26:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 17:26:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:26:45 INFO - (blobuploader) - INFO - Done attempting. 17:26:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 17:26:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:26:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:26:46 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 17:26:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:26:46 INFO - (blobuploader) - INFO - Done attempting. 17:26:46 INFO - (blobuploader) - INFO - Iteration through files over. 17:26:46 INFO - Return code: 0 17:26:46 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:26:46 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:26:46 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e855e98dcc5e01ca508a8e545c8fd871e8d7e0a46306b28e3abb514eb962d0cdbf191fb897e06ee859550f714ca974a9e7c9f7668bb34aa812a139c63c38d5b5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5cd0af83f992b8f155e551f1348b42e3dee5428cccf940ff2e1f1bd640e90043ceca91a7a80f70bb8e6fe95de85ca8d5a2a3dbae303870905bea78ab66f89064", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6445397709f4a503210c2c6f3422f6b8fac21af4aa08603eefcd1edfe12e8bdcdc48dc81642b75a4814ad02a57f5d3e9b0ce9372588b8c8456ecc83f13808a26", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/758b4ff537080c01baa45f5667e401ee357010b9597147b3f9b94dde5aadc969655bd4b1462485298c787f3fe187251ee1190a5ec921c79c3e1e1eb65391df0f"} 17:26:46 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:26:46 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:26:46 INFO - Contents: 17:26:46 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e855e98dcc5e01ca508a8e545c8fd871e8d7e0a46306b28e3abb514eb962d0cdbf191fb897e06ee859550f714ca974a9e7c9f7668bb34aa812a139c63c38d5b5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5cd0af83f992b8f155e551f1348b42e3dee5428cccf940ff2e1f1bd640e90043ceca91a7a80f70bb8e6fe95de85ca8d5a2a3dbae303870905bea78ab66f89064", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6445397709f4a503210c2c6f3422f6b8fac21af4aa08603eefcd1edfe12e8bdcdc48dc81642b75a4814ad02a57f5d3e9b0ce9372588b8c8456ecc83f13808a26", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/758b4ff537080c01baa45f5667e401ee357010b9597147b3f9b94dde5aadc969655bd4b1462485298c787f3fe187251ee1190a5ec921c79c3e1e1eb65391df0f"} 17:26:46 INFO - Running post-run listener: copy_logs_to_upload_dir 17:26:46 INFO - Copying logs to upload dir... 17:26:46 INFO - mkdir: /builds/slave/test/build/upload/logs 17:26:46 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1253.083006 ========= master_lag: 0.08 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2017-08-17 17:26:46.490985) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-17 17:26:46.498629) ========= 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=88e9d754c8c9af9f7805d7f3000001bd-1503014751.369548-710723835 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e855e98dcc5e01ca508a8e545c8fd871e8d7e0a46306b28e3abb514eb962d0cdbf191fb897e06ee859550f714ca974a9e7c9f7668bb34aa812a139c63c38d5b5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5cd0af83f992b8f155e551f1348b42e3dee5428cccf940ff2e1f1bd640e90043ceca91a7a80f70bb8e6fe95de85ca8d5a2a3dbae303870905bea78ab66f89064", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6445397709f4a503210c2c6f3422f6b8fac21af4aa08603eefcd1edfe12e8bdcdc48dc81642b75a4814ad02a57f5d3e9b0ce9372588b8c8456ecc83f13808a26", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/758b4ff537080c01baa45f5667e401ee357010b9597147b3f9b94dde5aadc969655bd4b1462485298c787f3fe187251ee1190a5ec921c79c3e1e1eb65391df0f"} build_url:https://queue.taskcluster.net/v1/task/b0RIcHGxQVmCDF_P3NNDKg/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011363 build_url: 'https://queue.taskcluster.net/v1/task/b0RIcHGxQVmCDF_P3NNDKg/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e855e98dcc5e01ca508a8e545c8fd871e8d7e0a46306b28e3abb514eb962d0cdbf191fb897e06ee859550f714ca974a9e7c9f7668bb34aa812a139c63c38d5b5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5cd0af83f992b8f155e551f1348b42e3dee5428cccf940ff2e1f1bd640e90043ceca91a7a80f70bb8e6fe95de85ca8d5a2a3dbae303870905bea78ab66f89064", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6445397709f4a503210c2c6f3422f6b8fac21af4aa08603eefcd1edfe12e8bdcdc48dc81642b75a4814ad02a57f5d3e9b0ce9372588b8c8456ecc83f13808a26", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/758b4ff537080c01baa45f5667e401ee357010b9597147b3f9b94dde5aadc969655bd4b1462485298c787f3fe187251ee1190a5ec921c79c3e1e1eb65391df0f"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-17 17:26:46.527867) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-17 17:26:46.528224) ========= 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=88e9d754c8c9af9f7805d7f3000001bd-1503014751.369548-710723835 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004486 ========= master_lag: 0.30 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-17 17:26:46.832983) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-17 17:26:46.835346) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-17 17:26:46.835637) ========= ========= Total master_lag: 0.45 =========