builder: mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s slave: talos-linux64-ix-034 starttime: 1503511522.71 results: success (0) revision: c86b7150523c10e1d1dbc0be2d8ed96f205be35f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-08-23 11:05:22.714052) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-08-23 11:05:22.714499) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-23 11:05:22.714776) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-23 11:05:22.775844) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-23 11:05:22.776117) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1503509401.652898-1074217580 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-08-23 11:05:22-- 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% 26.1M=0s 2017-08-23 11:05:22 (26.1 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.142073 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-23 11:05:22.934955) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-23 11:05:22.935280) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1503509401.652898-1074217580 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017027 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-23 11:05:22.987238) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-08-23 11:05:22.987535) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev c86b7150523c10e1d1dbc0be2d8ed96f205be35f --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 c86b7150523c10e1d1dbc0be2d8ed96f205be35f --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=d6bbd613908ccac0c6c9cb47000001f7-1503509401.652898-1074217580 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-08-23 11:05:23,023 truncating revision to first 12 chars 2017-08-23 11:05:23,023 Setting DEBUG logging. 2017-08-23 11:05:23,023 attempt 1/10 2017-08-23 11:05:23,023 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/c86b7150523c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-08-23 11:05:23,987 unpacking tar archive at: mozilla-central-c86b7150523c/testing/mozharness/ program finished with exit code 0 elapsedTime=1.273330 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-08-23 11:05:24.275795) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-23 11:05:24.276135) ========= script_repo_revision: c86b7150523c10e1d1dbc0be2d8ed96f205be35f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-23 11:05:24.276547) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-23 11:05:24.276918) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-23 11:05:24.287827) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2017-08-23 11:05:24.288281) ========= /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=d6bbd613908ccac0c6c9cb47000001f7-1503509401.652898-1074217580 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:05:24 INFO - MultiFileLogger online at 20170823 11:05:24 in /builds/slave/test 11:05:24 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 11:05:24 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:05:24 INFO - {'append_to_log': False, 11:05:24 INFO - 'base_work_dir': '/builds/slave/test', 11:05:24 INFO - 'blob_upload_branch': 'Firefox', 11:05:24 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:05:24 INFO - 'branch': 'Firefox', 11:05:24 INFO - 'buildbot_json_path': 'buildprops.json', 11:05:24 INFO - 'code_coverage': False, 11:05:24 INFO - 'config_files': ('talos/linux_config.py',), 11:05:24 INFO - 'default_actions': ('clobber', 11:05:24 INFO - 'read-buildbot-config', 11:05:24 INFO - 'download-and-extract', 11:05:24 INFO - 'populate-webroot', 11:05:24 INFO - 'create-virtualenv', 11:05:24 INFO - 'install', 11:05:24 INFO - 'setup-mitmproxy', 11:05:24 INFO - 'run-tests'), 11:05:24 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:05:24 INFO - 'disable_ccov_upload': False, 11:05:24 INFO - 'download_minidump_stackwalk': True, 11:05:24 INFO - 'download_symbols': 'ondemand', 11:05:24 INFO - 'enable_stylo': False, 11:05:24 INFO - 'enable_webrender': False, 11:05:24 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:05:24 INFO - 'tooltool.py': '/tools/tooltool.py', 11:05:24 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:05:24 INFO - '/tools/misc-python/virtualenv.py')}, 11:05:24 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:05:24 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:05:24 INFO - 'gecko_profile': False, 11:05:24 INFO - 'gecko_profile_interval': 0, 11:05:24 INFO - 'installer_path': 'installer.exe', 11:05:24 INFO - 'log_level': 'info', 11:05:24 INFO - 'log_name': 'talos', 11:05:24 INFO - 'log_to_console': True, 11:05:24 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:05:24 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:05:24 INFO - 'opt_config_files': (), 11:05:24 INFO - 'pip_index': False, 11:05:24 INFO - 'suite': 'dromaeojs-e10s', 11:05:24 INFO - 'system_bits': '32', 11:05:24 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:05:24 INFO - 'title': 'talos-linux64-ix-034', 11:05:24 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:05:24 INFO - 'use_talos_json': True, 11:05:24 INFO - 'verify': 'False', 11:05:24 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:05:24 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:05:24 INFO - 'work_dir': 'build'} 11:05:24 INFO - [mozharness: 2017-08-23 18:05:24.470121Z] Running clobber step. 11:05:24 INFO - Running pre-action listener: _resource_record_pre_action 11:05:24 INFO - Running main action method: clobber 11:05:24 INFO - rmtree: /builds/slave/test/build 11:05:24 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:05:25 INFO - Running post-action listener: _resource_record_post_action 11:05:25 INFO - [mozharness: 2017-08-23 18:05:25.479344Z] Finished clobber step (success) 11:05:25 INFO - [mozharness: 2017-08-23 18:05:25.479442Z] Running read-buildbot-config step. 11:05:25 INFO - Running pre-action listener: _resource_record_pre_action 11:05:25 INFO - Running main action method: read_buildbot_config 11:05:25 INFO - Using buildbot properties: 11:05:25 INFO - { 11:05:25 INFO - "project": "", 11:05:25 INFO - "product": "firefox", 11:05:25 INFO - "who": "ffxbld@noreply.mozilla.org", 11:05:25 INFO - "installer_path": "public/build/target.tar.bz2", 11:05:25 INFO - "builddir": "mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s", 11:05:25 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 11:05:25 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo mozilla-central talos dromaeojs-e10s", 11:05:25 INFO - "stage_platform": "linux64-stylo", 11:05:25 INFO - "basedir": "/builds/slave/test", 11:05:25 INFO - "buildnumber": 279, 11:05:25 INFO - "platform": "ubuntu64_hw_stylo", 11:05:25 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 11:05:25 INFO - "slavebuilddir": "test", 11:05:25 INFO - "taskId": "LVLRhdB_STKIWeXy3fnReQ", 11:05:25 INFO - "branch": "mozilla-central", 11:05:25 INFO - "script_repo_revision": "production", 11:05:25 INFO - "revision": "c86b7150523c10e1d1dbc0be2d8ed96f205be35f", 11:05:25 INFO - "slavename": "talos-linux64-ix-034", 11:05:25 INFO - "repo_path": "mozilla-central" 11:05:25 INFO - } 11:05:25 INFO - Finding installer, test and symbols from parent task. 11:05:25 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LVLRhdB_STKIWeXy3fnReQ'}, attempt #1 11:05:26 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LVLRhdB_STKIWeXy3fnReQ'}, attempt #1 11:05:26 INFO - Task dependencies: dxB5vMCrQHiaBdc7q5NgLw 11:05:26 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dxB5vMCrQHiaBdc7q5NgLw'}, attempt #1 11:05:27 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/dxB5vMCrQHiaBdc7q5NgLw/artifacts/public/build/target.tar.bz2 11:05:27 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/dxB5vMCrQHiaBdc7q5NgLw/artifacts/public/build/target.test_packages.json 11:05:27 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/dxB5vMCrQHiaBdc7q5NgLw/artifacts/public/build/target.crashreporter-symbols.zip 11:05:27 INFO - Running post-action listener: _resource_record_post_action 11:05:27 INFO - [mozharness: 2017-08-23 18:05:27.007692Z] Finished read-buildbot-config step (success) 11:05:27 INFO - [mozharness: 2017-08-23 18:05:27.007909Z] Running download-and-extract step. 11:05:27 INFO - Running pre-action listener: _resource_record_pre_action 11:05:27 INFO - Running main action method: download_and_extract 11:05:27 INFO - mkdir: /builds/slave/test/build/tests 11:05: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')]} 11:05:27 INFO - trying https://queue.taskcluster.net/v1/task/dxB5vMCrQHiaBdc7q5NgLw/artifacts/public/build/target.test_packages.json 11:05:27 INFO - Downloading https://queue.taskcluster.net/v1/task/dxB5vMCrQHiaBdc7q5NgLw/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 11:05:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dxB5vMCrQHiaBdc7q5NgLw/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 11:05:27 INFO - Downloaded 989 bytes. 11:05:27 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 11:05:27 INFO - Using the following test package requirements: 11:05:27 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 11:05:27 INFO - u'common': [u'target.common.tests.zip'], 11:05:27 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 11:05:27 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 11:05:27 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 11:05:27 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 11:05:27 INFO - u'mozbase': [u'target.common.tests.zip'], 11:05:27 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 11:05:27 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 11:05:27 INFO - u'web-platform': [u'target.common.tests.zip', 11:05:27 INFO - u'target.web-platform.tests.tar.gz'], 11:05:27 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 11:05:27 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 11:05:27 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/dxB5vMCrQHiaBdc7q5NgLw/artifacts/public/build/target.common.tests.zip 11:05:27 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dxB5vMCrQHiaBdc7q5NgLw/artifacts/public/build/target.common.tests.zip'}, attempt #1 11:05:27 INFO - Fetch https://queue.taskcluster.net/v1/task/dxB5vMCrQHiaBdc7q5NgLw/artifacts/public/build/target.common.tests.zip into memory 11:05:28 INFO - Content-Length response header: 54949494 11:05:28 INFO - Bytes received: 54949494 11:05:39 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 11:05:39 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/dxB5vMCrQHiaBdc7q5NgLw/artifacts/public/build/target.common.tests.zip 11:05:39 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dxB5vMCrQHiaBdc7q5NgLw/artifacts/public/build/target.common.tests.zip'}, attempt #1 11:05:39 INFO - Fetch https://queue.taskcluster.net/v1/task/dxB5vMCrQHiaBdc7q5NgLw/artifacts/public/build/target.common.tests.zip into memory 11:05:40 INFO - Content-Length response header: 54949494 11:05:40 INFO - Bytes received: 54949494 11:05:52 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/dxB5vMCrQHiaBdc7q5NgLw/artifacts/public/build/target.talos.tests.zip 11:05:52 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dxB5vMCrQHiaBdc7q5NgLw/artifacts/public/build/target.talos.tests.zip'}, attempt #1 11:05:52 INFO - Fetch https://queue.taskcluster.net/v1/task/dxB5vMCrQHiaBdc7q5NgLw/artifacts/public/build/target.talos.tests.zip into memory 11:05:53 INFO - Content-Length response header: 14496261 11:05:53 INFO - Bytes received: 14496261 11:05:53 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')]} 11:05:53 INFO - trying https://queue.taskcluster.net/v1/task/dxB5vMCrQHiaBdc7q5NgLw/artifacts/public/build/target.tar.bz2 11:05:53 INFO - Downloading https://queue.taskcluster.net/v1/task/dxB5vMCrQHiaBdc7q5NgLw/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 11:05:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dxB5vMCrQHiaBdc7q5NgLw/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 11:05:55 INFO - Downloaded 61043298 bytes. 11:05:55 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/dxB5vMCrQHiaBdc7q5NgLw/artifacts/public/build/target.tar.bz2 11:05:55 INFO - mkdir: /builds/slave/test/properties 11:05:55 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:05:55 INFO - Writing to file /builds/slave/test/properties/build_url 11:05:55 INFO - Contents: 11:05:55 INFO - build_url:https://queue.taskcluster.net/v1/task/dxB5vMCrQHiaBdc7q5NgLw/artifacts/public/build/target.tar.bz2 11:05:55 INFO - Running post-action listener: _resource_record_post_action 11:05:55 INFO - Running post-action listener: find_tests_for_verification 11:05:55 INFO - Running post-action listener: set_extra_try_arguments 11:05:55 INFO - [mozharness: 2017-08-23 18:05:55.017343Z] Finished download-and-extract step (success) 11:05:55 INFO - [mozharness: 2017-08-23 18:05:55.017440Z] Running populate-webroot step. 11:05:55 INFO - Running pre-action listener: _resource_record_pre_action 11:05:55 INFO - Running main action method: populate_webroot 11:05:55 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:05:55 INFO - 'chromez-stylo-e10s': {'talos_options': ['--stylo'], 11:05:55 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:05:55 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:05:55 INFO - 'dromaeojs-stylo-e10s': {'talos_options': ['--stylo'], 11:05:55 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:05:55 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 11:05:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:05:55 INFO - 'g1-stylo-e10s': {'pagesets_name': 'tp5n.zip', 11:05:55 INFO - 'talos_options': ['--stylo'], 11:05:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:05:55 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 11:05:55 INFO - 'tests': ['damp', 'tps']}, 11:05:55 INFO - 'g2-stylo-e10s': {'pagesets_name': 'tp5n.zip', 11:05:55 INFO - 'talos_options': ['--stylo'], 11:05:55 INFO - 'tests': ['damp', 'tps']}, 11:05:55 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:05:55 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 11:05:55 INFO - 'g4-stylo-e10s': {'talos_options': ['--stylo'], 11:05:55 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 11:05:55 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 11:05:55 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 11:05:55 INFO - 'g5-stylo-e10s': {'pagesets_name': 'tp5n.zip', 11:05:55 INFO - 'talos_options': ['--stylo'], 11:05:55 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 11:05:55 INFO - 'other-e10s': {'tests': ['a11yr', 11:05:55 INFO - 'ts_paint', 11:05:55 INFO - 'tpaint', 11:05:55 INFO - 'sessionrestore', 11:05:55 INFO - 'sessionrestore_many_windows', 11:05:55 INFO - 'sessionrestore_no_auto_restore', 11:05:55 INFO - 'tabpaint']}, 11:05:55 INFO - 'other-stylo-e10s': {'talos_options': ['--stylo'], 11:05:55 INFO - 'tests': ['a11yr', 11:05:55 INFO - 'ts_paint', 11:05:55 INFO - 'tpaint', 11:05:55 INFO - 'sessionrestore', 11:05:55 INFO - 'sessionrestore_many_windows', 11:05:55 INFO - 'sessionrestore_no_auto_restore', 11:05:55 INFO - 'tabpaint']}, 11:05:55 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 11:05:55 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 11:05:55 INFO - 'perf-reftest-singletons-stylo-e10s': {'talos_options': ['--stylo'], 11:05:55 INFO - 'tests': ['bloom_basic_singleton']}, 11:05:55 INFO - 'perf-reftest-stylo-e10s': {'talos_options': ['--stylo'], 11:05:55 INFO - 'tests': ['bloom_basic']}, 11:05:55 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:05:55 INFO - 'tsvgr_opacity', 11:05:55 INFO - 'tart', 11:05:55 INFO - 'tscrollx', 11:05:55 INFO - 'tsvg_static']}, 11:05:55 INFO - 'svgr-stylo-e10s': {'talos_options': ['--stylo'], 11:05:55 INFO - 'tests': ['tsvgx', 11:05:55 INFO - 'tsvgr_opacity', 11:05:55 INFO - 'tart', 11:05:55 INFO - 'tscrollx', 11:05:55 INFO - 'tsvg_static']}, 11:05:55 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 11:05:55 INFO - 'tp5o-stylo-e10s': {'pagesets_name': 'tp5n.zip', 11:05:55 INFO - 'talos_options': ['--stylo'], 11:05:55 INFO - 'tests': ['tp5o']}, 11:05:55 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:05:55 INFO - 'talos_options': ['--mitmproxy', 11:05:55 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:05:55 INFO - '--firstNonBlankPaint'], 11:05:55 INFO - 'tests': ['tp6_google', 11:05:55 INFO - 'tp6_youtube', 11:05:55 INFO - 'tp6_amazon', 11:05:55 INFO - 'tp6_facebook']}, 11:05:55 INFO - 'tp6-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:05:55 INFO - 'talos_options': ['--stylo', 11:05:55 INFO - '--mitmproxy', 11:05:55 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:05:55 INFO - '--firstNonBlankPaint'], 11:05:55 INFO - 'tests': ['tp6_google', 11:05:55 INFO - 'tp6_youtube', 11:05:55 INFO - 'tp6_amazon', 11:05:55 INFO - 'tp6_facebook']}, 11:05:55 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:05:55 INFO - 'talos_options': ['--stylo', 11:05:55 INFO - '--stylo-threads=1', 11:05:55 INFO - '--mitmproxy', 11:05:55 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:05:55 INFO - '--firstNonBlankPaint'], 11:05:55 INFO - 'tests': ['tp6_google', 11:05:55 INFO - 'tp6_youtube', 11:05:55 INFO - 'tp6_amazon', 11:05:55 INFO - 'tp6_facebook']}, 11:05:55 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 11:05:55 INFO - 'talos_options': ['--xperf_path', 11:05:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:05:55 INFO - 'tests': ['tp5n']}, 11:05:55 INFO - 'xperf-stylo-e10s': {'pagesets_name': 'tp5n.zip', 11:05:55 INFO - 'talos_options': ['--stylo', 11:05:55 INFO - '--xperf_path', 11:05:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:05:55 INFO - 'tests': ['tp5n']}}} 11:05:55 INFO - Running post-action listener: _resource_record_post_action 11:05:55 INFO - [mozharness: 2017-08-23 18:05:55.031628Z] Finished populate-webroot step (success) 11:05:55 INFO - [mozharness: 2017-08-23 18:05:55.031717Z] Running create-virtualenv step. 11:05:55 INFO - Running pre-action listener: _resource_record_pre_action 11:05:55 INFO - Running main action method: create_virtualenv 11:05:55 INFO - Creating virtualenv /builds/slave/test/build/venv 11:05:55 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 11:05:55 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:05:55 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 11:05:55 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:05:55 INFO - Using real prefix '/usr' 11:05:55 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:05:55 INFO - Installing distribute.............................................................................................................................................................................................done. 11:05:57 INFO - Installing pip.................done. 11:05:57 INFO - Return code: 0 11:05:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 11:05:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 11:05:57 INFO - Reading from file tmpfile_stdout 11:05:57 INFO - Output received: 11:05:57 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) 11:05:57 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:05:57 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')]} 11:05:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:05:57 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')]} 11:05:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:05:57 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 0x27481f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2913a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ab6f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ab4130>, '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 0x2ab5030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ab54c0>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1503509401.652898-1074217580', '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 11:05:57 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 11:05:57 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 11:05:57 INFO - Using env: {'DISPLAY': ':0', 11:05:57 INFO - 'HOME': '/home/cltbld', 11:05:57 INFO - 'LANG': 'en_US.UTF-8', 11:05:57 INFO - 'LANGUAGE': 'en_US:en', 11:05:57 INFO - 'LOGNAME': 'cltbld', 11:05:57 INFO - 'MAIL': '/var/mail/cltbld', 11:05:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:05:57 INFO - 'MOZ_NO_REMOTE': '1', 11:05:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:05:57 INFO - 'NO_EM_RESTART': '1', 11:05:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:05:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:05:57 INFO - 'PWD': '/builds/slave/test', 11:05:57 INFO - 'SHELL': '/bin/bash', 11:05:57 INFO - 'SHLVL': '1', 11:05:57 INFO - 'TERM': 'linux', 11:05:57 INFO - 'TMOUT': '86400', 11:05:57 INFO - 'USER': 'cltbld', 11:05:57 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1503509401.652898-1074217580', 11:05:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:05:57 INFO - '_': '/tools/buildbot/bin/python'} 11:05:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:05:58 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 11:05:58 INFO - Cleaning up... 11:05:58 INFO - Return code: 0 11:05:58 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:05:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:05:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:05:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:05:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:05:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x27481f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2913a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ab6f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ab4130>, '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 0x2ab5030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ab54c0>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1503509401.652898-1074217580', '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 11:05:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 11:05:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 11:05:58 INFO - Using env: {'DISPLAY': ':0', 11:05:58 INFO - 'HOME': '/home/cltbld', 11:05:58 INFO - 'LANG': 'en_US.UTF-8', 11:05:58 INFO - 'LANGUAGE': 'en_US:en', 11:05:58 INFO - 'LOGNAME': 'cltbld', 11:05:58 INFO - 'MAIL': '/var/mail/cltbld', 11:05:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:05:58 INFO - 'MOZ_NO_REMOTE': '1', 11:05:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:05:58 INFO - 'NO_EM_RESTART': '1', 11:05:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:05:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:05:58 INFO - 'PWD': '/builds/slave/test', 11:05:58 INFO - 'SHELL': '/bin/bash', 11:05:58 INFO - 'SHLVL': '1', 11:05:58 INFO - 'TERM': 'linux', 11:05:58 INFO - 'TMOUT': '86400', 11:05:58 INFO - 'USER': 'cltbld', 11:05:58 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1503509401.652898-1074217580', 11:05:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:05:58 INFO - '_': '/tools/buildbot/bin/python'} 11:05:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:05:58 INFO - Downloading/unpacking psutil>=3.1.1 11:05:58 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 11:05:58 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 11:05:58 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 11:05:58 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 11:05:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:05:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:05:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:05:59 INFO - Installing collected packages: psutil 11:05:59 INFO - Running setup.py install for psutil 11:05:59 INFO - building 'psutil._psutil_linux' extension 11:05:59 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 11:05:59 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 11:05:59 INFO - building 'psutil._psutil_posix' extension 11:05:59 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 11:05:59 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 11:05:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:05:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:05:59 INFO - Successfully installed psutil 11:05:59 INFO - Cleaning up... 11:05:59 INFO - Return code: 0 11:05:59 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:05:59 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')]} 11:05:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:05:59 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')]} 11:05:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:05:59 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 0x27481f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2913a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ab6f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ab4130>, '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 0x2ab5030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ab54c0>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1503509401.652898-1074217580', '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 11:05:59 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 11:05:59 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 11:05:59 INFO - Using env: {'DISPLAY': ':0', 11:05:59 INFO - 'HOME': '/home/cltbld', 11:05:59 INFO - 'LANG': 'en_US.UTF-8', 11:05:59 INFO - 'LANGUAGE': 'en_US:en', 11:05:59 INFO - 'LOGNAME': 'cltbld', 11:05:59 INFO - 'MAIL': '/var/mail/cltbld', 11:05:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:05:59 INFO - 'MOZ_NO_REMOTE': '1', 11:05:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:05:59 INFO - 'NO_EM_RESTART': '1', 11:05:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:05:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:05:59 INFO - 'PWD': '/builds/slave/test', 11:05:59 INFO - 'SHELL': '/bin/bash', 11:05:59 INFO - 'SHLVL': '1', 11:05:59 INFO - 'TERM': 'linux', 11:05:59 INFO - 'TMOUT': '86400', 11:05:59 INFO - 'USER': 'cltbld', 11:05:59 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1503509401.652898-1074217580', 11:05:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:05:59 INFO - '_': '/tools/buildbot/bin/python'} 11:06:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:06:00 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:06:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:06:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:06:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:06:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:06:01 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:06:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:06:01 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:06:01 INFO - Installing collected packages: mozsystemmonitor 11:06:01 INFO - Running setup.py install for mozsystemmonitor 11:06:01 INFO - Successfully installed mozsystemmonitor 11:06:01 INFO - Cleaning up... 11:06:01 INFO - Return code: 0 11:06:01 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:06:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:06:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:06:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:06:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:06:01 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 0x27481f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2913a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ab6f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ab4130>, '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 0x2ab5030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ab54c0>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1503509401.652898-1074217580', '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 11:06:01 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 11:06:01 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 11:06:01 INFO - Using env: {'DISPLAY': ':0', 11:06:01 INFO - 'HOME': '/home/cltbld', 11:06:01 INFO - 'LANG': 'en_US.UTF-8', 11:06:01 INFO - 'LANGUAGE': 'en_US:en', 11:06:01 INFO - 'LOGNAME': 'cltbld', 11:06:01 INFO - 'MAIL': '/var/mail/cltbld', 11:06:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:06:01 INFO - 'MOZ_NO_REMOTE': '1', 11:06:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:06:01 INFO - 'NO_EM_RESTART': '1', 11:06:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:06:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:06:01 INFO - 'PWD': '/builds/slave/test', 11:06:01 INFO - 'SHELL': '/bin/bash', 11:06:01 INFO - 'SHLVL': '1', 11:06:01 INFO - 'TERM': 'linux', 11:06:01 INFO - 'TMOUT': '86400', 11:06:01 INFO - 'USER': 'cltbld', 11:06:01 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1503509401.652898-1074217580', 11:06:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:06:01 INFO - '_': '/tools/buildbot/bin/python'} 11:06:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:06:01 INFO - Downloading/unpacking jsonschema==2.5.1 11:06:01 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 11:06:01 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 11:06:01 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 11:06:01 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 11:06:02 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:06:02 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:06:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:06:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:06:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:06:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:06:03 INFO - Downloading functools32-3.2.3-2.tar.gz 11:06:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:06:03 INFO - warning: no files found matching '*.txt' 11:06:03 INFO - no previously-included directories found matching 'build' 11:06:03 INFO - no previously-included directories found matching 'dist' 11:06:03 INFO - no previously-included directories found matching '.git*' 11:06:03 INFO - Installing collected packages: jsonschema, functools32 11:06:03 INFO - Running setup.py install for functools32 11:06:03 INFO - warning: no files found matching '*.txt' 11:06:03 INFO - no previously-included directories found matching 'build' 11:06:03 INFO - no previously-included directories found matching 'dist' 11:06:03 INFO - no previously-included directories found matching '.git*' 11:06:03 INFO - Successfully installed jsonschema functools32 11:06:03 INFO - Cleaning up... 11:06:03 INFO - Return code: 0 11:06:03 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 11:06:03 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')]} 11:06:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:06:03 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')]} 11:06:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:06:03 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 0x27481f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2913a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ab6f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ab4130>, '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 0x2ab5030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ab54c0>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1503509401.652898-1074217580', '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 11:06:03 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 11:06:03 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 11:06:03 INFO - Using env: {'DISPLAY': ':0', 11:06:03 INFO - 'HOME': '/home/cltbld', 11:06:03 INFO - 'LANG': 'en_US.UTF-8', 11:06:03 INFO - 'LANGUAGE': 'en_US:en', 11:06:03 INFO - 'LOGNAME': 'cltbld', 11:06:03 INFO - 'MAIL': '/var/mail/cltbld', 11:06:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:06:03 INFO - 'MOZ_NO_REMOTE': '1', 11:06:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:06:03 INFO - 'NO_EM_RESTART': '1', 11:06:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:06:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:06:03 INFO - 'PWD': '/builds/slave/test', 11:06:03 INFO - 'SHELL': '/bin/bash', 11:06:03 INFO - 'SHLVL': '1', 11:06:03 INFO - 'TERM': 'linux', 11:06:03 INFO - 'TMOUT': '86400', 11:06:03 INFO - 'USER': 'cltbld', 11:06:03 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1503509401.652898-1074217580', 11:06:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:06:03 INFO - '_': '/tools/buildbot/bin/python'} 11:06:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:06:03 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 11:06:03 INFO - Cleaning up... 11:06:03 INFO - Return code: 0 11:06:03 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:06:03 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')]} 11:06:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:06:03 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')]} 11:06:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:06:03 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 0x27481f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2913a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ab6f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ab4130>, '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 0x2ab5030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ab54c0>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1503509401.652898-1074217580', '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 11:06:03 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 11:06:03 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 11:06:03 INFO - Using env: {'DISPLAY': ':0', 11:06:03 INFO - 'HOME': '/home/cltbld', 11:06:03 INFO - 'LANG': 'en_US.UTF-8', 11:06:03 INFO - 'LANGUAGE': 'en_US:en', 11:06:03 INFO - 'LOGNAME': 'cltbld', 11:06:03 INFO - 'MAIL': '/var/mail/cltbld', 11:06:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:06:03 INFO - 'MOZ_NO_REMOTE': '1', 11:06:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:06:03 INFO - 'NO_EM_RESTART': '1', 11:06:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:06:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:06:03 INFO - 'PWD': '/builds/slave/test', 11:06:03 INFO - 'SHELL': '/bin/bash', 11:06:03 INFO - 'SHLVL': '1', 11:06:03 INFO - 'TERM': 'linux', 11:06:03 INFO - 'TMOUT': '86400', 11:06:03 INFO - 'USER': 'cltbld', 11:06:03 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1503509401.652898-1074217580', 11:06:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:06:03 INFO - '_': '/tools/buildbot/bin/python'} 11:06:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:06:03 INFO - Downloading/unpacking blobuploader==1.2.4 11:06:03 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 11:06:03 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 11:06:03 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 11:06:03 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 11:06:04 INFO - Downloading blobuploader-1.2.4.tar.gz 11:06:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:06:04 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:06:04 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 11:06:04 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 11:06:04 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 11:06:04 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 11:06:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:06:05 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:06:05 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 11:06:05 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 11:06:05 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 11:06:05 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 11:06:05 INFO - Downloading docopt-0.6.1.tar.gz 11:06:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:06:05 INFO - Installing collected packages: blobuploader, requests, docopt 11:06:05 INFO - Running setup.py install for blobuploader 11:06:05 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:06:05 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:06:05 INFO - Running setup.py install for requests 11:06:05 INFO - Running setup.py install for docopt 11:06:05 INFO - Successfully installed blobuploader requests docopt 11:06:05 INFO - Cleaning up... 11:06:06 INFO - Return code: 0 11:06:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:06:06 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')]} 11:06:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:06:06 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')]} 11:06:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:06:06 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 0x27481f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2913a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ab6f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ab4130>, '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 0x2ab5030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ab54c0>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1503509401.652898-1074217580', '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 11:06:06 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 11:06:06 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 11:06:06 INFO - Using env: {'DISPLAY': ':0', 11:06:06 INFO - 'HOME': '/home/cltbld', 11:06:06 INFO - 'LANG': 'en_US.UTF-8', 11:06:06 INFO - 'LANGUAGE': 'en_US:en', 11:06:06 INFO - 'LOGNAME': 'cltbld', 11:06:06 INFO - 'MAIL': '/var/mail/cltbld', 11:06:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:06:06 INFO - 'MOZ_NO_REMOTE': '1', 11:06:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:06:06 INFO - 'NO_EM_RESTART': '1', 11:06:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:06:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:06:06 INFO - 'PWD': '/builds/slave/test', 11:06:06 INFO - 'SHELL': '/bin/bash', 11:06:06 INFO - 'SHLVL': '1', 11:06:06 INFO - 'TERM': 'linux', 11:06:06 INFO - 'TMOUT': '86400', 11:06:06 INFO - 'USER': 'cltbld', 11:06:06 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1503509401.652898-1074217580', 11:06:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:06:06 INFO - '_': '/tools/buildbot/bin/python'} 11:06:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:06:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:06:06 INFO - Running setup.py (path:/tmp/pip-iMoSdc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:06:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:06:06 INFO - Running setup.py (path:/tmp/pip-j6_HYV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:06:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:06:06 INFO - Running setup.py (path:/tmp/pip-dJvPmj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:06:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:06:06 INFO - Running setup.py (path:/tmp/pip-XsHPiT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:06:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:06:06 INFO - Running setup.py (path:/tmp/pip-J6mtAA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:06:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:06:06 INFO - Running setup.py (path:/tmp/pip-0q6BdU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:06:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:06:06 INFO - Running setup.py (path:/tmp/pip-COSnpL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:06:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:06:06 INFO - Running setup.py (path:/tmp/pip-LxJ60b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:06:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:06:06 INFO - Running setup.py (path:/tmp/pip-T2c7QX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:06:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:06:06 INFO - Running setup.py (path:/tmp/pip-LAB0Xe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:06:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:06:06 INFO - Running setup.py (path:/tmp/pip-5lPnjm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:06:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:06:07 INFO - Running setup.py (path:/tmp/pip-uHi6Ng-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:06:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:06:07 INFO - Running setup.py (path:/tmp/pip-yJGvjV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:06:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:06:07 INFO - Running setup.py (path:/tmp/pip-Onq1QS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:06:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:06:07 INFO - Running setup.py (path:/tmp/pip-72dZMt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:06:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:06:07 INFO - Running setup.py (path:/tmp/pip-IMUsVL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:06:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:06:07 INFO - Running setup.py (path:/tmp/pip-xGZHpp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:06:07 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:06:07 INFO - Running setup.py install for manifestparser 11:06:07 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:06:07 INFO - Running setup.py install for mozcrash 11:06:07 INFO - Running setup.py install for mozdebug 11:06:07 INFO - Running setup.py install for mozdevice 11:06:07 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:06:07 INFO - Running setup.py install for mozfile 11:06:07 INFO - Running setup.py install for mozhttpd 11:06:08 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:06:08 INFO - Running setup.py install for mozinfo 11:06:08 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:06:08 INFO - Running setup.py install for mozInstall 11:06:08 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:06:08 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:06:08 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:06:08 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:06:08 INFO - Running setup.py install for mozleak 11:06:08 INFO - Running setup.py install for mozlog 11:06:08 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:06:08 INFO - Running setup.py install for moznetwork 11:06:08 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:06:08 INFO - Running setup.py install for mozprocess 11:06:08 INFO - Running setup.py install for mozprofile 11:06:08 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:06:08 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:06:08 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:06:08 INFO - Running setup.py install for mozrunner 11:06:08 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:06:08 INFO - Running setup.py install for mozscreenshot 11:06:09 INFO - Running setup.py install for moztest 11:06:09 INFO - Running setup.py install for mozversion 11:06:09 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:06:09 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:06:09 INFO - Cleaning up... 11:06:09 INFO - Return code: 0 11:06:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:06:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:06:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:06:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:06:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:06:09 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 0x27481f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2913a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ab6f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ab4130>, '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 0x2ab5030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ab54c0>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1503509401.652898-1074217580', '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 11:06:09 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 11:06:09 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 11:06:09 INFO - Using env: {'DISPLAY': ':0', 11:06:09 INFO - 'HOME': '/home/cltbld', 11:06:09 INFO - 'LANG': 'en_US.UTF-8', 11:06:09 INFO - 'LANGUAGE': 'en_US:en', 11:06:09 INFO - 'LOGNAME': 'cltbld', 11:06:09 INFO - 'MAIL': '/var/mail/cltbld', 11:06:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:06:09 INFO - 'MOZ_NO_REMOTE': '1', 11:06:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:06:09 INFO - 'NO_EM_RESTART': '1', 11:06:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:06:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:06:09 INFO - 'PWD': '/builds/slave/test', 11:06:09 INFO - 'SHELL': '/bin/bash', 11:06:09 INFO - 'SHLVL': '1', 11:06:09 INFO - 'TERM': 'linux', 11:06:09 INFO - 'TMOUT': '86400', 11:06:09 INFO - 'USER': 'cltbld', 11:06:09 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1503509401.652898-1074217580', 11:06:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:06:09 INFO - '_': '/tools/buildbot/bin/python'} 11:06:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:06:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:06:09 INFO - Running setup.py (path:/tmp/pip-c7me8F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:06:09 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)) 11:06:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:06:09 INFO - Running setup.py (path:/tmp/pip-S8C4jd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:06:09 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)) 11:06:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:06:09 INFO - Running setup.py (path:/tmp/pip-6D6Z0f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:06:09 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)) 11:06:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:06:09 INFO - Running setup.py (path:/tmp/pip-TtOKqm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:06:09 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)) 11:06:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:06:09 INFO - Running setup.py (path:/tmp/pip-RDMemo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:06:09 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)) 11:06:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:06:09 INFO - Running setup.py (path:/tmp/pip-8fo4lH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:06:09 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)) 11:06:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:06:09 INFO - Running setup.py (path:/tmp/pip-Zu1e_J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:06:10 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)) 11:06:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:06:10 INFO - Running setup.py (path:/tmp/pip-GnWrBh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:06:10 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)) 11:06:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:06:10 INFO - Running setup.py (path:/tmp/pip-EMLysS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:06:10 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)) 11:06:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:06:10 INFO - Running setup.py (path:/tmp/pip-mIQPC_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:06:10 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)) 11:06:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:06:10 INFO - Running setup.py (path:/tmp/pip-broUan-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:06:10 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)) 11:06:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:06:10 INFO - Running setup.py (path:/tmp/pip-TEd4Da-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:06:10 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)) 11:06:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:06:10 INFO - Running setup.py (path:/tmp/pip-NEyC16-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:06:10 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)) 11:06:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:06:10 INFO - Running setup.py (path:/tmp/pip-gLw1RF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:06:10 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)) 11:06:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:06:10 INFO - Running setup.py (path:/tmp/pip-yxzB4_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:06:10 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)) 11:06:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:06:10 INFO - Running setup.py (path:/tmp/pip-3o62h4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:06:10 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)) 11:06:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:06:10 INFO - Running setup.py (path:/tmp/pip-p47diV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:06:10 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)) 11:06:10 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)) 11:06:10 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)) 11:06:10 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)) 11:06:10 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)) 11:06:10 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)) 11:06:10 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)) 11:06:10 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:06:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:06:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:06:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:06:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:06:11 INFO - Downloading blessings-1.6.tar.gz 11:06:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:06:11 INFO - Installing collected packages: blessings 11:06:11 INFO - Running setup.py install for blessings 11:06:12 INFO - Successfully installed blessings 11:06:12 INFO - Cleaning up... 11:06:12 INFO - Return code: 0 11:06:12 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:06:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:06:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:06:12 INFO - Reading from file tmpfile_stdout 11:06:12 INFO - Current package versions: 11:06:12 INFO - argparse == 1.2.1 11:06:12 INFO - blessings == 1.6 11:06:12 INFO - blobuploader == 1.2.4 11:06:12 INFO - docopt == 0.6.1 11:06:12 INFO - functools32 == 3.2.3-2 11:06:12 INFO - jsonschema == 2.5.1 11:06:12 INFO - manifestparser == 1.1 11:06:12 INFO - mozInstall == 1.13 11:06:12 INFO - mozcrash == 1.0 11:06:12 INFO - mozdebug == 0.1 11:06:12 INFO - mozdevice == 0.51 11:06:12 INFO - mozfile == 1.2 11:06:12 INFO - mozhttpd == 0.7 11:06:12 INFO - mozinfo == 0.10 11:06:12 INFO - mozleak == 0.1 11:06:12 INFO - mozlog == 3.5 11:06:12 INFO - moznetwork == 0.27 11:06:12 INFO - mozprocess == 0.25 11:06:12 INFO - mozprofile == 0.28 11:06:12 INFO - mozrunner == 6.13 11:06:12 INFO - mozscreenshot == 0.1 11:06:12 INFO - mozsystemmonitor == 0.3 11:06:12 INFO - moztest == 0.8 11:06:12 INFO - mozversion == 1.4 11:06:12 INFO - psutil == 3.1.1 11:06:12 INFO - requests == 1.2.3 11:06:12 INFO - wsgiref == 0.1.2 11:06:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:06:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:06:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:06:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:06:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:06:12 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 0x27481f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2913a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ab6f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ab4130>, '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 0x2ab5030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ab54c0>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1503509401.652898-1074217580', '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 11:06:12 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 11:06:12 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 11:06:12 INFO - Using env: {'DISPLAY': ':0', 11:06:12 INFO - 'HOME': '/home/cltbld', 11:06:12 INFO - 'LANG': 'en_US.UTF-8', 11:06:12 INFO - 'LANGUAGE': 'en_US:en', 11:06:12 INFO - 'LOGNAME': 'cltbld', 11:06:12 INFO - 'MAIL': '/var/mail/cltbld', 11:06:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:06:12 INFO - 'MOZ_NO_REMOTE': '1', 11:06:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:06:12 INFO - 'NO_EM_RESTART': '1', 11:06:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:06:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:06:12 INFO - 'PWD': '/builds/slave/test', 11:06:12 INFO - 'SHELL': '/bin/bash', 11:06:12 INFO - 'SHLVL': '1', 11:06:12 INFO - 'TERM': 'linux', 11:06:12 INFO - 'TMOUT': '86400', 11:06:12 INFO - 'USER': 'cltbld', 11:06:12 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1503509401.652898-1074217580', 11:06:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:06:12 INFO - '_': '/tools/buildbot/bin/python'} 11:06:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:06:12 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)) 11:06:12 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)) 11:06:12 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)) 11:06:12 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)) 11:06:12 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)) 11:06:12 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)) 11:06:12 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)) 11:06:12 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)) 11:06:12 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)) 11:06:12 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 11:06:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:06:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:06:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:06:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:06:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 11:06:13 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)) 11:06:13 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)) 11:06:13 INFO - Installing collected packages: simplejson 11:06:13 INFO - Running setup.py install for simplejson 11:06:13 INFO - building 'simplejson._speedups' extension 11:06:13 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 11:06:14 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 11:06:14 INFO - Successfully installed simplejson 11:06:14 INFO - Cleaning up... 11:06:14 INFO - Return code: 0 11:06:14 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:06:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:06:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:06:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:06:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:06:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27481f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2913a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ab6f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ab4130>, '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 0x2ab5030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ab54c0>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1503509401.652898-1074217580', '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 11:06:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 11:06:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 11:06:14 INFO - Using env: {'DISPLAY': ':0', 11:06:14 INFO - 'HOME': '/home/cltbld', 11:06:14 INFO - 'LANG': 'en_US.UTF-8', 11:06:14 INFO - 'LANGUAGE': 'en_US:en', 11:06:14 INFO - 'LOGNAME': 'cltbld', 11:06:14 INFO - 'MAIL': '/var/mail/cltbld', 11:06:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:06:14 INFO - 'MOZ_NO_REMOTE': '1', 11:06:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:06:14 INFO - 'NO_EM_RESTART': '1', 11:06:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:06:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:06:14 INFO - 'PWD': '/builds/slave/test', 11:06:14 INFO - 'SHELL': '/bin/bash', 11:06:14 INFO - 'SHLVL': '1', 11:06:14 INFO - 'TERM': 'linux', 11:06:14 INFO - 'TMOUT': '86400', 11:06:14 INFO - 'USER': 'cltbld', 11:06:14 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1503509401.652898-1074217580', 11:06:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:06:14 INFO - '_': '/tools/buildbot/bin/python'} 11:06:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:06:14 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:06:14 INFO - Cleaning up... 11:06:15 INFO - Return code: 0 11:06:15 INFO - Running post-action listener: _resource_record_post_action 11:06:15 INFO - Running post-action listener: _start_resource_monitoring 11:06:15 INFO - Starting resource monitoring. 11:06:15 INFO - [mozharness: 2017-08-23 18:06:15.028574Z] Finished create-virtualenv step (success) 11:06:15 INFO - [mozharness: 2017-08-23 18:06:15.029086Z] Running install step. 11:06:15 INFO - Running pre-action listener: _resource_record_pre_action 11:06:15 INFO - Running main action method: install 11:06:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:06:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:06:15 INFO - Reading from file tmpfile_stdout 11:06:15 INFO - Detecting whether we're running mozinstall >=1.0... 11:06:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:06:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:06:15 INFO - Reading from file tmpfile_stdout 11:06:15 INFO - Output received: 11:06:15 INFO - Usage: mozinstall [options] installer 11:06:15 INFO - Options: 11:06:15 INFO - -h, --help show this help message and exit 11:06:15 INFO - -d DEST, --destination=DEST 11:06:15 INFO - Directory to install application into. [default: 11:06:15 INFO - "/builds/slave/test"] 11:06:15 INFO - --app=APP Application being installed. [default: firefox] 11:06:15 INFO - mkdir: /builds/slave/test/build/application 11:06:15 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'] 11:06:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 11:06:33 INFO - Reading from file tmpfile_stdout 11:06:33 INFO - Output received: 11:06:33 INFO - /builds/slave/test/build/application/firefox/firefox 11:06:33 INFO - Running post-action listener: _resource_record_post_action 11:06:33 INFO - [mozharness: 2017-08-23 18:06:33.037122Z] Finished install step (success) 11:06:33 INFO - [mozharness: 2017-08-23 18:06:33.037463Z] Running setup-mitmproxy step. 11:06:33 INFO - Running pre-action listener: _resource_record_pre_action 11:06:33 INFO - Running main action method: setup_mitmproxy 11:06:33 INFO - Skipping: mitmproxy is not required 11:06:33 INFO - Running post-action listener: _resource_record_post_action 11:06:33 INFO - [mozharness: 2017-08-23 18:06:33.038601Z] Finished setup-mitmproxy step (success) 11:06:33 INFO - [mozharness: 2017-08-23 18:06:33.038819Z] Running run-tests step. 11:06:33 INFO - Running pre-action listener: _resource_record_pre_action 11:06:33 INFO - Running pre-action listener: _set_gcov_prefix 11:06:33 INFO - Running main action method: run_tests 11:06:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:06:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:06:33 INFO - Python 2.7.3 11:06:33 INFO - Return code: 0 11:06:33 INFO - grabbing minidump binary from tooltool 11:06:33 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')]} 11:06:33 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 0x2ab4130>, '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 0x2ab5030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ab54c0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:06:33 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 11:06:33 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 11:06:33 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 11:06:33 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:06:33 INFO - Return code: 0 11:06:33 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:06:33 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:06:33 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:06:33 INFO - ENV: RUST_BACKTRACE is now full 11:06:33 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:06:33 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:06:33 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/dxB5vMCrQHiaBdc7q5NgLw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-034', '--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 11:06:33 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/dxB5vMCrQHiaBdc7q5NgLw/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-034 --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 11:06:33 INFO - Using env: {'DISPLAY': ':0', 11:06:33 INFO - 'HOME': '/home/cltbld', 11:06:33 INFO - 'LANG': 'en_US.UTF-8', 11:06:33 INFO - 'LANGUAGE': 'en_US:en', 11:06:33 INFO - 'LOGNAME': 'cltbld', 11:06:33 INFO - 'MAIL': '/var/mail/cltbld', 11:06:33 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:06:33 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:06:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:06:33 INFO - 'MOZ_NO_REMOTE': '1', 11:06:33 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:06:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:06:33 INFO - 'NO_EM_RESTART': '1', 11:06:33 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:06:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:06:33 INFO - 'PWD': '/builds/slave/test', 11:06:33 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:06:33 INFO - 'RUST_BACKTRACE': 'full', 11:06:33 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 11:06:33 INFO - 'SHELL': '/bin/bash', 11:06:33 INFO - 'SHLVL': '1', 11:06:33 INFO - 'STYLO_FORCE_ENABLED': '1', 11:06:33 INFO - 'TERM': 'linux', 11:06:33 INFO - 'TMOUT': '86400', 11:06:33 INFO - 'USER': 'cltbld', 11:06:33 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1503509401.652898-1074217580', 11:06:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:06:33 INFO - '_': '/tools/buildbot/bin/python'} 11:06:33 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/dxB5vMCrQHiaBdc7q5NgLw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-034', '--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 11:06:33 INFO - mozversion application_buildid: 20170823172102 11:06:33 INFO - mozversion application_changeset: c86b7150523c10e1d1dbc0be2d8ed96f205be35f 11:06:33 INFO - mozversion application_display_name: Nightly 11:06:33 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:06:33 INFO - mozversion application_name: Firefox 11:06:33 INFO - mozversion application_remotingname: firefox 11:06:33 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 11:06:33 INFO - mozversion application_vendor: Mozilla 11:06:33 INFO - mozversion application_version: 57.0a1 11:06:33 INFO - mozversion platform_buildid: 20170823172102 11:06:33 INFO - mozversion platform_changeset: c86b7150523c10e1d1dbc0be2d8ed96f205be35f 11:06:33 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 11:06:33 INFO - mozversion platform_version: 57.0a1 11:06:33 INFO - using testdate: 1503511593 11:06:33 INFO - actual date: 1503511593 11:06:33 INFO - starting webserver on 'localhost:46226' 11:06:33 INFO - SUITE-START | Running 2 tests 11:06:33 INFO - TEST-START | dromaeo_css 11:06:33 INFO - Initialising browser for dromaeo_css test... 11:06:33 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:46226/getInfo.html -profile /tmp/tmphcneEu/profile 11:06:33 INFO - TEST-INFO | started process 9102 (/builds/slave/test/build/application/firefox/firefox http://localhost:46226/getInfo.html) 11:06:39 INFO - TEST-INFO | 9102: exit 0 11:06:39 INFO - Browser initialized. 11:06:39 INFO - Running cycle 1/1 for dromaeo_css test... 11:06:39 INFO - TEST-INFO | started process 9293 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphcneEu/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 11:06:40 INFO - PID 9293 | 11:06:40 INFO - PID 9293 | (/builds/slave/test/build/application/firefox/firefox:9342): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 11:06:40 INFO - PID 9293 | 11:06:41 INFO - PID 9293 | 11:06:41 INFO - PID 9293 | (/builds/slave/test/build/application/firefox/firefox:9404): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 11:06:41 INFO - PID 9293 | 11:06:41 INFO - PID 9293 | __metrics Screen width/height:1600/1200 11:06:41 INFO - PID 9293 | colorDepth:24 11:06:41 INFO - PID 9293 | Browser inner width/height: 1024/768 11:06:41 INFO - PID 9293 | __metrics 11:06:51 INFO - PID 9293 | RSS: Main: 174309376 11:06:51 INFO - PID 9293 | 11:09:49 INFO - PID 9293 | Cycle 1(1): loaded http://localhost:46226/tests/dromaeo/cssquery-dojo.html (next: http://localhost:46226/tests/dromaeo/cssquery-ext.html) 11:09:51 INFO - PID 9293 | RSS: Main: 178388992 11:09:51 INFO - PID 9293 | 11:12:53 INFO - PID 9293 | Cycle 1(1): loaded http://localhost:46226/tests/dromaeo/cssquery-ext.html (next: http://localhost:46226/tests/dromaeo/cssquery-jquery.html) 11:12:54 INFO - PID 9293 | RSS: Main: 174665728 11:12:54 INFO - PID 9293 | 11:15:55 INFO - PID 9293 | Cycle 1(1): loaded http://localhost:46226/tests/dromaeo/cssquery-jquery.html (next: http://localhost:46226/tests/dromaeo/cssquery-mootools.html) 11:15:56 INFO - PID 9293 | RSS: Main: 177721344 11:15:56 INFO - PID 9293 | 11:18:58 INFO - PID 9293 | Cycle 1(1): loaded http://localhost:46226/tests/dromaeo/cssquery-mootools.html (next: http://localhost:46226/tests/dromaeo/cssquery-prototype.html) 11:18:58 INFO - PID 9293 | RSS: Main: 173686784 11:18:58 INFO - PID 9293 | 11:22:02 INFO - PID 9293 | Cycle 1(1): loaded http://localhost:46226/tests/dromaeo/cssquery-prototype.html (next: http://localhost:46226/tests/dromaeo/cssquery-yui.html) 11:22:03 INFO - PID 9293 | RSS: Main: 178642944 11:22:03 INFO - PID 9293 | 11:25:05 INFO - PID 9293 | Cycle 1(1): loaded http://localhost:46226/tests/dromaeo/cssquery-yui.html (next: http://localhost:46226/tests/dromaeo/cssquery-dojo.html) 11:25:05 INFO - PID 9293 | RSS: Main: 180379648 11:25:05 INFO - PID 9293 | 11:25:05 INFO - PID 9293 | __start_tp_report 11:25:05 INFO - PID 9293 | _x_x_mozilla_page_load 11:25:05 INFO - PID 9293 | _x_x_mozilla_page_load_details 11:25:05 INFO - PID 9293 | |i|pagename|runs| 11:25:05 INFO - PID 9293 | |0;dojo.html;3244.4160051190793;3262.983685081574;3272.7545434092417;3293.440115180419;3309.4704847224434;6177.505799536038;6199.690015499224;6230.1900752902175;6243.750249990001;6255;6093.817185484442;6167.198264225655;6189.628622282667;6197.535184861143;6226.968865155679;5710.457506536873;5715.228444160048;5729.512991395715;5745.683987380692;5763.1355296705415;5720.513756330717;5755.280589926259;5770.480656740892;5801;5841.678707671076;5748.482636562709;5832.737526811283;5837.44544268296;5843.590948633576;5848.1812546243345;5515.806946756844;5715.628484148517;5731.111677689964;5767.192593036999;5773.076307790754;5608.327000759894;5609.186667933127;5627.155926611;5671.234383358235;5672.659640421588;6043.48912771807;6078.756849726005;6192.783252586183;6207.937920620826;6215.316315205324;6544.640044797582;6550.475961923034;6571.474282057424;6658.533902626818;6693.46452283821;6688.531802773808;6706.798796036127;6780.694868730919;6803.251642319341;6808.931910680879;6115.7859474918605;6142.477889379364;6169.722362493699;6232.0963460298;6253;6677.198736151693;6829.556078854858;6846.144231971004;6869.244383117853;6892.241853396123;6421.101045853584;6556.3443655634055;6556.803295901131;6568.441682457044;6617.735290588419;6671.86656266872;6701.765438209639;6729.966350168218;6745.8650826983185;6755.324467553303;6614.272430032693;6615.37153970372;6627.900581491282;6709.161354830646;6739.292374300726;6591.802245932629;6670.733170673216;6671.432928201158;6676.551996836656;6720.059191713164;5302;5307.495787900143;5310.6813591184655;5313.707746074003;5318.468153184728;4623.029163875556;4679.251319788886;4702.130105930414;4737.218358970731;4743.146233677902;5827.621204621686;5870.706464676835;5902.2622172228475;5910.468057874812;5912.46787789101;6723.495737819585;6733.831654208684;6745.763898263537;6785.728570857209;6816.488763342769;5699.116636921284;5764.452377024176;5799.3620701722775;5838.7080645967535;5848.795292164754;5766.365699773021;5777.364489906191;5786.826395208066;5792.189093526909;5794.739236734357;6265;6269.247690277196;6275.529335299871;6369;6369.968150159312;6586.407223349922;6608.8347791305605;6688.933110669026;6692.59844409337;6701.497387696039;6319.557630965788;6331.335209803088;6332.936670633235;6338.366163383625;6346.650934198663;6574.342565743387;6636.27001029896;6639.136912201383;6643.800685979429;6670.166229221348;6707.3292670732535;6727.360900714424;6734.4612431004425;6811.557248778813;6812.727490900308;6341.460975817107;6475.481961442979;6504.869902602016;6589.703463344257;6596.406323430914;6425.228972523327;6450.258220304538;6524.021396790519;6524.641144737085;6527.11883895668;6311.684415779285;6403.135576697273;6417.7753778617525;6427.228732552124;6501.6099034056215;6493.123428337114;6513.2835388108215;6546.672666366568;6547.541672082908;6548.47612191014;6304.275008374096;6304.306526282014;6329.461995730415;6404.839879002876;6422.26143993428 11:25:05 INFO - PID 9293 | |1;ext.html;770.3836930455637;807.903051633804;815.6125840225892;849.9320054395647;855.3072011670544;39001.80499097504;39825.0043748906;39930.60069399305;39959;40036.39945400821;36031.639683603156;36425.453618195745;36425.81787091061;36478.27043459129;36482.087947801316;6884.345987131214;6979.546329488592;6986.545874518166;6988.930110698879;6999.475039372042;6878.58728476293;6948.826279343031;6953.304669533057;6955.965220173917;6956.1652601687865;6935.445164386837;7611.200823913492;7762;7804.414668899827;7808.4924479908905;7700.961495192516;7764.145943946161;7768.145503994556;7770.805729856742;7779.72770953014;7506.587137707424;7625.237476252386;7732.1108072571815;7732.922670773332;7734.110577283628;36962.26075478502;37199.44200836989;37354.06614834624;37382.62617373819;37398.25203495915;3477.791332520057;3488.7383446241633;3510.5611798525183;3517.56030496188;3519.964800351989;30637;30716.692833071607;30839.537406938915;30862.537061944087;30934.690653093407;5145.922811157836;5181.844544663666;5185.144451165553;5188.533032027136;5204.115300398941;183719.08140459345;185328;185806;187629;198328.99999999854;46412.53587464149;47075.76462117668;47338;47389;47411.28883066757;48703;48897;49050.264246036335;49091.263631045564;49110.75444622754;13502.459901603826;13573.04988650785;13575.321233938264;13647.454101836014;13653.590392288248;10942.726431839108;10970.835437468444;10979.231453798158;10983.286086404358;11002;13238.669033274053;13258;13269;13285;13496.257705826274;5450.683459529684;5556.749946252428;5564.8330550083565;5567.721613919288;5586;993.8608594796734;996.461910568285;1002.9949850250848;1014.3457469931852;1014.8376259798545;22375.77624223737;22735.204267850877;22753.544929101325;22806.42983925382;22896.427589310402;1067.9839802402971;1074.3768614203743;1094.534822700365;1100.2518287564374;1100.4112799652148;11791;12014.63956081319;12125;15660.530184094496;15665.45170919035;238227;239238;240305;240345;240358;55055.522501486725;55079.44920550823;55545.444545554026;55615.16577251344;55684;1388.1046724862408;1404.2346920928119;1411.5624156511515;1416.5750274917484;1417.3905220755175;26418.867905660347;26678.066267680537;26941;26973.730262697907;27611.861940690167;34679.30641387209;34889;35226.823865880506;35263.64736352706;35281.82359088188;212394;213865;214327;214618;215695;32815.835920820246;33000.504992424656;33619;33632.66367336393;33759.4936075964;40440;41705;42212.577874220864;42243.3663495054;42480.36279455749;30710.232244194074;31026;31207.84396078005;31222.21944451407;31225.84387078141;29986;30549.694503054685;30864.382712345177;30884.382312354075;30953.690463095983;34743.65256347505;34803.303933921685;35126.82436587903;35414.291714165054;35441.64558354383;29719.25701857471;29730;30117.397652047275;30272.697273026988;30565.54151687771;22190.131168019987;22575.887120564294;22844.657330140395;22929;23067.22039695107 11:25:05 INFO - PID 9293 | |2;jquery.html;549.3654828672882;550.7466565379925;552.748499432758;557.436988641472;572.5333852909878;21774.455638609044;21813.23653672122;22590.54818903621;22592.54814903701;22600.43498912526;24852.384595001313;25525.872370638168;25553.23340299794;25589;25601.871990640022;7105.076340075783;7257.129144502667;7263.854722905538;7274.527155734887;7289.599072051035;6534.215894092692;7094.929050709478;7148.642567871611;7159.427245820322;7166.104236970379;7122.821929451753;7157.498975071747;7164.85670286594;7166.677499512534;7171.318724721144;7167.964160179192;7170.8565828683395;7174.103237095389;7181.856362872713;7195.208527062019;7017.193022802341;7035.788926332167;7044.682989265495;7046.6828992695455;7047.083879095736;30196.396072078434;30950.0714978551;31118.222044448845;31135.22161945947;31159.53260701091;2074.471009892483;2101;2103.253345062496;2104.2635077722825;2113.3131732187103;20462.181512739473;21186.36440906775;21206.257780977747;21208.151673933025;21234.5753084939;2483.2177863972793;2494.875256237199;2537.644729737838;2563.192594332798;2618.5417551928335;137508.31245843807;140982;141338.29330853486;141512;141587;19249.32627358036;20848.583028339348;21010.47473813167;21431;22163.889180553993;22451.887740561193;23219.419514512272;23376.181833635743;23378.415539611648;41685.79157104195;9263.397879137834;9380.577873995686;9486.667966621135;9508.429494230368;9601.47191904452;8486.660533578588;8537.829243415097;8602.31181505478;8625.91374086251;8678.609462574199;8908.777280567909;9005.819883602422;9078.500682462529;9115.908840911507;9496.097870702271;2562.6540417043834;2574.8970041198518;2578.3425226567106;2683.5974603809586;2735.2478068531314;939.478589382899;958.5399008475831;965.4255717847869;967.0281367225892;987;19353.612927741648;19391.3213037543;19479.902600487192;19850.305239316844;19980.50048748764;1005.1355833982769;1019.592163134752;1033.9017793309624;1038.127972503101;1043.7703705184847;10747.689246811973;10784;10848.67453976382;11050.613228537124;11168.888311116785;511498;511664;547460;547831;556893;115147.42426287815;116986;119047;119149;124667;1197.4192516629428;1215.1736818963013;1249.631358749171;1254.4605819497522;1255.6672481792332;19170.808291916903;19267.421977340702;19295.614087718448;19588.8452270253;19937.302194423126;52359.47640523546;53062.2040669398;54671.17993230025;56003.43996559982;56094;65261;68125.65937170283;68403.3159668397;68462.31537684759;68615.65692171507;13960.092593981359;14443.78334325007;14604.12375257488;14668.853311466748;14675.972681912164;22853.428664283525;22879;22884.88557557268;22901.19845805389;23020.884895575415;18220.90889545544;18673.53316167107;18694.813051869307;18716.906415467834;18841.15214815309;15846.603834903759;15989.920050399674;16366.672666546841;16403.67192656164;16521.421750238685;18511;18992.810071899105;19194.424167275003;19209.615807683487;19219.039048047263;14333.140011599337;14359.066660667024;14436;14498;14506;17002.319907203575;17130.057846818545;17137.571560711083;18307.267709292013;18484.907575462035 11:25:05 INFO - PID 9293 | |3;mootools.html;1257.6164269897681;1312.6980794417284;1336.3585478970087;1337.284552764271;1348.6291269900769;14216.715665686681;14651.706965860676;14837.183954882477;14917.179555124463;14929.178895160761;15337.463188788395;15438.84561154388;15565.37738490459;15580.065196088242;15601.843981560181;2634.1307368568328;2694.6631671041023;2697.932551686204;2699.8650067496646;2708.79684023698;2492.5513407586627;2598.8440693558446;2660.7472290132505;2661.095227622608;2661.7737492313177;2704.418550011747;2706.3098909777977;2719.415325704973;2720.795940304475;2724.82288651238;2686.1135825177644;2709.647745793054;2712.0643378034547;2713.9728602713917;2717.9592306115424;2595.922122336333;2647.721989191146;2653.2173008962404;2656.8538730369823;2657.162993657011;14281.357338919774;14516.129032258099;14516.491922782652;14520.70958580833;14526.927365363106;7784.221577842227;8039.919600804034;8053.798655033613;8053.798655033613;8059.395545334065;5180.792768289301;5359.196120581944;5448;5463.399026107125;5472;1824.1517694272227;1869.5139263791377;1875.7936626971023;1914.741509896174;1915.0807612346014;24343.87828060866;24486.877565612234;24565.508689826103;24600.753992460024;24609.63085553718;6577.34226577348;6585.506087043491;6593.6703164841565;6745.2242992056545;6746.325367463214;16393.34426622922;16410.671786564202;16413.1793410329;16416.589585260226;16420.096894670667;7441.627918604048;7570.810729731801;7574.772756817304;7577.128630207597;7585.127710313384;6134.78528251509;6921.204061532988;6959.826004349932;6994.370506654425;7034.824129396806;4872.317875497433;5126.974365128151;5283.392409872837;5308.654937429054;5319.28189694394;1505.759078547449;1555.113585256393;1561.8360072192256;1567.4592265668325;1579.7077540655016;892.7277180459893;908.4276905549593;910.544727636182;919.2048877720723;926.9988412514468;8167.591620418955;8528.53093079874;8612.48325100496;8654.394192406597;8655.56722163902;967.1923943507251;994.4977786218059;995.5520015992832;1012.6455740490769;1013.640157744005;5166.535011848877;5262.236975638511;5362.785488580491;5394.379646340721;5399.649022813504;19460.80539194618;20049.09779059946;20286.188552458032;20436.897815510827;20452.897735511226;19512;20034.499137521387;20058.197672093243;20157.294494692615;20174.193032278545;10547.736306592244;10770.73073173177;10809.567617295377;10911.83632245517;10981.505832237408;8118.2693557580105;8480.151984801718;8489.787755306166;8575.614097365758;8782;17214.741778873577;17462.82537174612;17688.55778605494;17817.643647127243;18070.277188912296;17478.475645730647;17902.28390864403;17961.73057404114;18093.819061809212;18182.818171818642;11394.715132121763;11728.88271117312;11744.236624619372;11752.11859110553;11793.115516336138;12089.516419343128;12392.256464612152;12534.059945503941;13186.736265274449;13575.728485430038;10328.122109620766;10436.060754532129;10525.263231574023;10538.051575358255;10676.252662313564;10706.571737130738;10723.571057157938;10909.18181136402;10921.781564368826;10965.396903170402;9726.076022777825;9828.4102953823;9915.950420247853;9919.950400247953;9920;7064.522707039002;7090.113735783028;7199.327333064756;7210.2789721027475;7263.201047884834;7273.745418910313;7360.0063991360485;7371.926280737124;7455.254474552501;7498.512596681198 11:25:05 INFO - PID 9293 | |4;prototype.html;490.5323497627212;490.7300984458548;514.6140394703972;522.386196219442;528.2208742105393;6286.339934306895;6344.1752572165615;6373.585716928396;6383.58506697065;6412.935870641292;6290.245170579526;6332.936670633292;6336.366363363662;6353.237611486628;6357.1417858589075;5189.974050129763;5200.427952925175;5204.843854684346;5217.608679349045;5237.685738855681;5096.923546146811;5118;5210.609204309673;5228.215767634866;5249.031613145071;4875.146849301375;4961.578265847407;4966.453690094087;4980.750962451881;5016.523430274136;4993.226049962262;5001.949980500185;5016.874578135539;5018.222175562793;5024.698518088926;4371.388005679208;4452.888677783049;4491.416115904912;4495.752733599651;4509.301058335963;6097.054956481708;6196.659183744892;6209;6220.906686399708;6229.221347331583;5657.8585535361535;5744.368119506851;5776;5777.706707176911;5780.421957804228;6658.667066646648;6674.06563081169;6674.2658307586125;6674.733010679567;6679.499037572153;4919.777545707568;4936.555709986083;4940.975295123501;4943.777530011158;4946.752662366867;6730.427913627299;6878.7248510060035;6932.72269109235;6938.757143499954;6973.267806880255;5025.14572522672;5027.597792176617;5032.547070763576;5042.394912610437;5054.772535235923;5093;5104.795808167706;5115.258287548285;5116.155834287375;5118.897622047538;5643.689597072201;5702.151048042555;5706.229658995982;5730.856728581819;5756;6617.437517810944;6671.766488172891;6683.331666833375;6688.86622267552;6703.156631926162;1722.0786879019665;1727.9136043197789;1736.661351036561;1742.7995780485153;1750.6761249168944;1164.6040346282305;1198.328935795957;1217.391304347826;1234.4444999750149;1238.8823061809114;5805.187273781674;5813.418658134153;5864.354920958691;5864.67744274069;5917.142014407973;6760.301590394629;6780.559263647847;6820.590764554044;6846.931530684729;6898.241193468714;5778.306603207642;5820.796272130455;5854.238948936696;5857.560682948796;5873.2658417697785;3588.8564457421935;3601.549806274216;3619.6561326673923;3623.7282203834816;3654.2326111516877;6369.522285828489;6370.458511026522;6402.679866006774;6415.454686351619;6476.125723027425;6906.374153569316;6947.444204463631;6968.372846443743;6976.616286104211;7006.649667516604;6060.515158787286;6394.616323020634;6414.807555773335;6421.335145914393;6459.418652321314;6772.898406523807;6784.185897692309;6787.457003439614;6822;6844.863102738017;6718.294579069127;6722.630255335808;6730;6737.730490780314;6779.35596118368;6399.712012959335;6412.070249813844;6441.613503189824;6451.1290975717675;6465.741370345134;4932.778024988812;4946.233333833262;4959.9008019838675;5025.447200807835;5052.090623687772;6546.705398256994;6661.134052573135;6697.51266651335;6733.023711561894;6769;6528.335274504971;6550.246721626883;6586.176727909012;6600.768973086111;6613.140291762233;6539.934600653933;6556.246031706415;6556.770513032021;6560.114384558024;6602.702878370389;6434.227892652912;6441.71012304438;6503.6097834130105;6518.771842985473;6562.77030303937;6611;6649.135612370361;6712.93287067123;6738.46092312604;6763.154605674291;6417.486601071996;6476.935230647633;6497.577657452251;6515.641639709862;6523.739050438119 11:25:05 INFO - PID 9293 | |5;yui.html;866.3718803867197;882.9426087304325;901.7159594727665;916.0564618443002;920.3189639666649;18120.27518899244;19143.32998345058;19201.327953521628;19245.615087698272;22440.214592489265;20394.286199983002;20746.273880414188;21042.053107610154;21132.15471381147;21149.788502114974;916.4730280088942;939.2908354192575;943.8489841625342;943.9905600944006;945.0124619772355;889.2930120554142;940.8682784410188;946.981060378792;960.5101398286854;963.6771681486675;1001.9298649094567;1009.530568285747;1012.9392236465799;1013.8124446977296;1014.4927536231884;999.5502024089153;1000.104906109032;1000.4897502273857;1000.9399436033862;1001.4692213127055;738.2986163145034;738.8337624034549;738.9298016688459;739.3235189801379;739.3973911262304;19164.233430662756;19620.50948726279;19907;19925.501862453555;20033.79966200334;21258;21306.786932130635;21785;21786.237481688222;21881.12475500978;15520.14639194855;15911.761323580156;15991.28039238237;16015.599610009844;16125.274362653709;3559.288142371536;3566.983409728241;3587.264610754789;3617.656322649344;3619.855205791765;124998;125691;127095;127857;128387.35806321002;16231.756523651919;16554.255058522154;16820.0748958806;17125.48623541296;17245;29840.40319193604;30206.84896575503;30340.69659303423;30364.089077327273;30521.38957220843;7830.686772529035;8160;8161.959190204011;9026.548672566345;9039.638414463348;4322.113966636832;4385.736855788663;4398.208322501981;4415.735055896656;4417.050334178167;4895.485973972753;4969.27945447908;5027.2207807789855;5060.3927528696795;5078.263651770472;970.2771435280761;976.7362812040851;994.1549682769588;996.4768496539375;999.4053538144792;606.8786242751468;671.2113266911359;693.0470602920983;711.0010435338357;711.1288671377624;11247.212695111428;11264.549418023187;11781.941090294666;13363.33183340829;14146.858531414555;674.6356967237637;692.1106378303956;696.8710788504143;699.5068476723898;707.9752208672671;5522.447755224445;5931.851703707442;6144.07838824171;6178.011518157074;6181;106151;108673;109897;111370.44314778375;112956.43521782338;97713.5114324438;99465;99614;100049.49975250078;104867;87620;89348.5532572333;90096;90243.54878225568;92333;11859.644210673694;12512.749745004867;12528.74942501163;12717.936410317889;13095.541656041993;39954.80022599868;40012.1997560053;40574;41424.58575414207;42451.3632295522;68438.65780671065;70497.64751176417;72036;73576.26423735694;74144;17893;18066.36767713124;18153.546161346072;18167.27330906749;18541.536461588566;18699.906500467412;19094.331698391044;19179.520511987314;19202.231910723414;19247.90376048167;20070;20086.296979605642;20266.18935242574;20321.390358289274;20448.182072717518;17472.475825725247;18460.353887614405;18590.628187436447;18776.81223187805;19267.71098433553;17810.821891781434;17928.551786205448;17986.91006544959;18231.544211394823;18475.63048738991;12538.373081345713;12632.178908370926;12731.55439559611;12869.613911582668;12959.611211663665;13772.586822395344;14117.43530258778;14200.928995354958;14323.427062917366;14976.775348370002 11:25:05 INFO - PID 9293 | __end_tp_report 11:25:05 INFO - PID 9293 | __start_cc_report 11:25:05 INFO - PID 9293 | _x_x_mozilla_cycle_collect,386 11:25:05 INFO - PID 9293 | __end_cc_report 11:25:05 INFO - PID 9293 | __startTimestamp1503512705593__endTimestamp 11:25:05 INFO - PID 9293 | 11:25:05 INFO - PID 9293 | ------- Summary: start ------- 11:25:05 INFO - PID 9293 | Number of tests: 6 11:25:05 INFO - PID 9293 | 11:25:05 INFO - PID 9293 | [#0] dojo.html Cycles:165 Average:6141.06 Median:6329.46 stddev:702.70 (11.1%) stddev-sans-first:667.11 11:25:05 INFO - PID 9293 | Values: 3244.4 3263.0 3272.8 3293.4 3309.5 6177.5 6199.7 6230.2 6243.8 6255.0 6093.8 6167.2 6189.6 6197.5 6227.0 5710.5 5715.2 5729.5 5745.7 5763.1 5720.5 5755.3 5770.5 5801.0 5841.7 5748.5 5832.7 5837.4 5843.6 5848.2 5515.8 5715.6 5731.1 5767.2 5773.1 5608.3 5609.2 5627.2 5671.2 5672.7 6043.5 6078.8 6192.8 6207.9 6215.3 6544.6 6550.5 6571.5 6658.5 6693.5 6688.5 6706.8 6780.7 6803.3 6808.9 6115.8 6142.5 6169.7 6232.1 6253.0 6677.2 6829.6 6846.1 6869.2 6892.2 6421.1 6556.3 6556.8 6568.4 6617.7 6671.9 6701.8 6730.0 6745.9 6755.3 6614.3 6615.4 6627.9 6709.2 6739.3 6591.8 6670.7 6671.4 6676.6 6720.1 5302.0 5307.5 5310.7 5313.7 5318.5 4623.0 4679.3 4702.1 4737.2 4743.1 5827.6 5870.7 5902.3 5910.5 5912.5 6723.5 6733.8 6745.8 6785.7 6816.5 5699.1 5764.5 5799.4 5838.7 5848.8 5766.4 5777.4 5786.8 5792.2 5794.7 6265.0 6269.2 6275.5 6369.0 6370.0 6586.4 6608.8 6688.9 6692.6 6701.5 6319.6 6331.3 6332.9 6338.4 6346.7 6574.3 6636.3 6639.1 6643.8 6670.2 6707.3 6727.4 6734.5 6811.6 6812.7 6341.5 6475.5 6504.9 6589.7 6596.4 6425.2 6450.3 6524.0 6524.6 6527.1 6311.7 6403.1 6417.8 6427.2 6501.6 6493.1 6513.3 6546.7 6547.5 6548.5 6304.3 6304.3 6329.5 6404.8 6422.3 11:25:05 INFO - PID 9293 | 11:25:05 INFO - PID 9293 | [#1] ext.html Cycles:180 Average:37611.56 Median:19140.55 stddev:55850.16 (291.8%) stddev-sans-first:55938.33 11:25:05 INFO - PID 9293 | Values: 770.4 807.9 815.6 849.9 855.3 39001.8 39825.0 39930.6 39959.0 40036.4 36031.6 36425.5 36425.8 36478.3 36482.1 6884.3 6979.5 6986.5 6988.9 6999.5 6878.6 6948.8 6953.3 6956.0 6956.2 6935.4 7611.2 7762.0 7804.4 7808.5 7701.0 7764.1 7768.1 7770.8 7779.7 7506.6 7625.2 7732.1 7732.9 7734.1 36962.3 37199.4 37354.1 37382.6 37398.3 3477.8 3488.7 3510.6 3517.6 3520.0 30637.0 30716.7 30839.5 30862.5 30934.7 5145.9 5181.8 5185.1 5188.5 5204.1 183719.1 185328.0 185806.0 187629.0 198329.0 46412.5 47075.8 47338.0 47389.0 47411.3 48703.0 48897.0 49050.3 49091.3 49110.8 13502.5 13573.0 13575.3 13647.5 13653.6 10942.7 10970.8 10979.2 10983.3 11002.0 13238.7 13258.0 13269.0 13285.0 13496.3 5450.7 5556.7 5564.8 5567.7 5586.0 993.9 996.5 1003.0 1014.3 1014.8 22375.8 22735.2 22753.5 22806.4 22896.4 1068.0 1074.4 1094.5 1100.3 1100.4 11791.0 12014.6 12125.0 15660.5 15665.5 238227.0 239238.0 240305.0 240345.0 240358.0 55055.5 55079.4 55545.4 55615.2 55684.0 1388.1 1404.2 1411.6 1416.6 1417.4 26418.9 26678.1 26941.0 26973.7 27611.9 34679.3 34889.0 35226.8 35263.6 35281.8 212394.0 213865.0 214327.0 214618.0 215695.0 32815.8 33000.5 33619.0 33632.7 33759.5 40440.0 41705.0 42212.6 42243.4 42480.4 30710.2 31026.0 31207.8 31222.2 31225.8 29986.0 30549.7 30864.4 30884.4 30953.7 34743.7 34803.3 35126.8 35414.3 35441.6 29719.3 29730.0 30117.4 30272.7 30565.5 22190.1 22575.9 22844.7 22929.0 23067.2 11:25:05 INFO - PID 9293 | 11:25:05 INFO - PID 9293 | [#2] jquery.html Cycles:180 Average:36428.20 Median:23120.15 stddev:89659.53 (387.8%) stddev-sans-first:89870.58 11:25:05 INFO - PID 9293 | Values: 549.4 550.7 552.7 557.4 572.5 21774.5 21813.2 22590.5 22592.5 22600.4 24852.4 25525.9 25553.2 25589.0 25601.9 7105.1 7257.1 7263.9 7274.5 7289.6 6534.2 7094.9 7148.6 7159.4 7166.1 7122.8 7157.5 7164.9 7166.7 7171.3 7168.0 7170.9 7174.1 7181.9 7195.2 7017.2 7035.8 7044.7 7046.7 7047.1 30196.4 30950.1 31118.2 31135.2 31159.5 2074.5 2101.0 2103.3 2104.3 2113.3 20462.2 21186.4 21206.3 21208.2 21234.6 2483.2 2494.9 2537.6 2563.2 2618.5 137508.3 140982.0 141338.3 141512.0 141587.0 19249.3 20848.6 21010.5 21431.0 22163.9 22451.9 23219.4 23376.2 23378.4 41685.8 9263.4 9380.6 9486.7 9508.4 9601.5 8486.7 8537.8 8602.3 8625.9 8678.6 8908.8 9005.8 9078.5 9115.9 9496.1 2562.7 2574.9 2578.3 2683.6 2735.2 939.5 958.5 965.4 967.0 987.0 19353.6 19391.3 19479.9 19850.3 19980.5 1005.1 1019.6 1033.9 1038.1 1043.8 10747.7 10784.0 10848.7 11050.6 11168.9 511498.0 511664.0 547460.0 547831.0 556893.0 115147.4 116986.0 119047.0 119149.0 124667.0 1197.4 1215.2 1249.6 1254.5 1255.7 19170.8 19267.4 19295.6 19588.8 19937.3 52359.5 53062.2 54671.2 56003.4 56094.0 65261.0 68125.7 68403.3 68462.3 68615.7 13960.1 14443.8 14604.1 14668.9 14676.0 22853.4 22879.0 22884.9 22901.2 23020.9 18220.9 18673.5 18694.8 18716.9 18841.2 15846.6 15989.9 16366.7 16403.7 16521.4 18511.0 18992.8 19194.4 19209.6 19219.0 14333.1 14359.1 14436.0 14498.0 14506.0 17002.3 17130.1 17137.6 18307.3 18484.9 11:25:05 INFO - PID 9293 | 11:25:05 INFO - PID 9293 | [#3] mootools.html Cycles:180 Average:9007.17 Median:2640.93 stddev:6226.21 (235.8%) stddev-sans-first:6216.44 11:25:05 INFO - PID 9293 | Values: 1257.6 1312.7 1336.4 1337.3 1348.6 14216.7 14651.7 14837.2 14917.2 14929.2 15337.5 15438.8 15565.4 15580.1 15601.8 2634.1 2694.7 2697.9 2699.9 2708.8 2492.6 2598.8 2660.7 2661.1 2661.8 2704.4 2706.3 2719.4 2720.8 2724.8 2686.1 2709.6 2712.1 2714.0 2718.0 2595.9 2647.7 2653.2 2656.9 2657.2 14281.4 14516.1 14516.5 14520.7 14526.9 7784.2 8039.9 8053.8 8053.8 8059.4 5180.8 5359.2 5448.0 5463.4 5472.0 1824.2 1869.5 1875.8 1914.7 1915.1 24343.9 24486.9 24565.5 24600.8 24609.6 6577.3 6585.5 6593.7 6745.2 6746.3 16393.3 16410.7 16413.2 16416.6 16420.1 7441.6 7570.8 7574.8 7577.1 7585.1 6134.8 6921.2 6959.8 6994.4 7034.8 4872.3 5127.0 5283.4 5308.7 5319.3 1505.8 1555.1 1561.8 1567.5 1579.7 892.7 908.4 910.5 919.2 927.0 8167.6 8528.5 8612.5 8654.4 8655.6 967.2 994.5 995.6 1012.6 1013.6 5166.5 5262.2 5362.8 5394.4 5399.6 19460.8 20049.1 20286.2 20436.9 20452.9 19512.0 20034.5 20058.2 20157.3 20174.2 10547.7 10770.7 10809.6 10911.8 10981.5 8118.3 8480.2 8489.8 8575.6 8782.0 17214.7 17462.8 17688.6 17817.6 18070.3 17478.5 17902.3 17961.7 18093.8 18182.8 11394.7 11728.9 11744.2 11752.1 11793.1 12089.5 12392.3 12534.1 13186.7 13575.7 10328.1 10436.1 10525.3 10538.1 10676.3 10706.6 10723.6 10909.2 10921.8 10965.4 9726.1 9828.4 9916.0 9920.0 9920.0 7064.5 7090.1 7199.3 7210.3 7263.2 7273.7 7360.0 7371.9 7455.3 7498.5 11:25:05 INFO - PID 9293 | 11:25:05 INFO - PID 9293 | [#4] prototype.html Cycles:180 Average:5562.20 Median:6257.78 stddev:1560.91 (24.9%) stddev-sans-first:1518.16 11:25:05 INFO - PID 9293 | Values: 490.5 490.7 514.6 522.4 528.2 6286.3 6344.2 6373.6 6383.6 6412.9 6290.2 6332.9 6336.4 6353.2 6357.1 5190.0 5200.4 5204.8 5217.6 5237.7 5096.9 5118.0 5210.6 5228.2 5249.0 4875.1 4961.6 4966.5 4980.8 5016.5 4993.2 5001.9 5016.9 5018.2 5024.7 4371.4 4452.9 4491.4 4495.8 4509.3 6097.1 6196.7 6209.0 6220.9 6229.2 5657.9 5744.4 5776.0 5777.7 5780.4 6658.7 6674.1 6674.3 6674.7 6679.5 4919.8 4936.6 4941.0 4943.8 4946.8 6730.4 6878.7 6932.7 6938.8 6973.3 5025.1 5027.6 5032.5 5042.4 5054.8 5093.0 5104.8 5115.3 5116.2 5118.9 5643.7 5702.2 5706.2 5730.9 5756.0 6617.4 6671.8 6683.3 6688.9 6703.2 1722.1 1727.9 1736.7 1742.8 1750.7 1164.6 1198.3 1217.4 1234.4 1238.9 5805.2 5813.4 5864.4 5864.7 5917.1 6760.3 6780.6 6820.6 6846.9 6898.2 5778.3 5820.8 5854.2 5857.6 5873.3 3588.9 3601.5 3619.7 3623.7 3654.2 6369.5 6370.5 6402.7 6415.5 6476.1 6906.4 6947.4 6968.4 6976.6 7006.6 6060.5 6394.6 6414.8 6421.3 6459.4 6772.9 6784.2 6787.5 6822.0 6844.9 6718.3 6722.6 6730.0 6737.7 6779.4 6399.7 6412.1 6441.6 6451.1 6465.7 4932.8 4946.2 4959.9 5025.4 5052.1 6546.7 6661.1 6697.5 6733.0 6769.0 6528.3 6550.2 6586.2 6600.8 6613.1 6539.9 6556.2 6556.8 6560.1 6602.7 6434.2 6441.7 6503.6 6518.8 6562.8 6611.0 6649.1 6712.9 6738.5 6763.2 6417.5 6476.9 6497.6 6515.6 6523.7 11:25:05 INFO - PID 9293 | 11:25:05 INFO - PID 9293 | [#5] yui.html Cycles:180 Average:24045.77 Median:21282.39 stddev:32610.64 (153.2%) stddev-sans-first:32655.68 11:25:05 INFO - PID 9293 | Values: 866.4 882.9 901.7 916.1 920.3 18120.3 19143.3 19201.3 19245.6 22440.2 20394.3 20746.3 21042.1 21132.2 21149.8 916.5 939.3 943.8 944.0 945.0 889.3 940.9 947.0 960.5 963.7 1001.9 1009.5 1012.9 1013.8 1014.5 999.6 1000.1 1000.5 1000.9 1001.5 738.3 738.8 738.9 739.3 739.4 19164.2 19620.5 19907.0 19925.5 20033.8 21258.0 21306.8 21785.0 21786.2 21881.1 15520.1 15911.8 15991.3 16015.6 16125.3 3559.3 3567.0 3587.3 3617.7 3619.9 124998.0 125691.0 127095.0 127857.0 128387.4 16231.8 16554.3 16820.1 17125.5 17245.0 29840.4 30206.8 30340.7 30364.1 30521.4 7830.7 8160.0 8162.0 9026.5 9039.6 4322.1 4385.7 4398.2 4415.7 4417.1 4895.5 4969.3 5027.2 5060.4 5078.3 970.3 976.7 994.2 996.5 999.4 606.9 671.2 693.0 711.0 711.1 11247.2 11264.5 11781.9 13363.3 14146.9 674.6 692.1 696.9 699.5 708.0 5522.4 5931.9 6144.1 6178.0 6181.0 106151.0 108673.0 109897.0 111370.4 112956.4 97713.5 99465.0 99614.0 100049.5 104867.0 87620.0 89348.6 90096.0 90243.5 92333.0 11859.6 12512.7 12528.7 12717.9 13095.5 39954.8 40012.2 40574.0 41424.6 42451.4 68438.7 70497.6 72036.0 73576.3 74144.0 17893.0 18066.4 18153.5 18167.3 18541.5 18699.9 19094.3 19179.5 19202.2 19247.9 20070.0 20086.3 20266.2 20321.4 20448.2 17472.5 18460.4 18590.6 18776.8 19267.7 17810.8 17928.6 17986.9 18231.5 18475.6 12538.4 12632.2 12731.6 12869.6 12959.6 13772.6 14117.4 14200.9 14323.4 14976.8 11:25:05 INFO - PID 9293 | -------- Summary: end -------- 11:25:05 INFO - PID 9293 | 11:25:06 INFO - TEST-INFO | 9293: exit 0 11:25:06 INFO - TEST-OK | dromaeo_css | took 1112962ms 11:25:06 INFO - TEST-START | kraken 11:25:06 INFO - Initialising browser for kraken test... 11:25:06 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:46226/getInfo.html -profile /tmp/tmpOT5hxk/profile 11:25:06 INFO - TEST-INFO | started process 9718 (/builds/slave/test/build/application/firefox/firefox http://localhost:46226/getInfo.html) 11:25:11 INFO - TEST-INFO | 9718: exit 0 11:25:12 INFO - Browser initialized. 11:25:12 INFO - Running cycle 1/1 for kraken test... 11:25:12 INFO - TEST-INFO | started process 9905 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOT5hxk/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 11:25:13 INFO - PID 9905 | 11:25:13 INFO - PID 9905 | (/builds/slave/test/build/application/firefox/firefox:9955): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 11:25:13 INFO - PID 9905 | 11:25:13 INFO - PID 9905 | 11:25:13 INFO - PID 9905 | (/builds/slave/test/build/application/firefox/firefox:10014): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 11:25:13 INFO - PID 9905 | 11:25:13 INFO - PID 9905 | __metrics Screen width/height:1600/1200 11:25:13 INFO - PID 9905 | colorDepth:24 11:25:13 INFO - PID 9905 | Browser inner width/height: 1024/768 11:25:13 INFO - PID 9905 | __metrics 11:25:23 INFO - PID 9905 | RSS: Main: 174878720 11:25:23 INFO - PID 9905 | 11:25:26 INFO - PID 9905 | Cycle 1(1): loaded http://localhost:46226/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:46226/tests/kraken/driver.html?testName=audio-beat-detection) 11:25:27 INFO - PID 9905 | RSS: Main: 178929664 11:25:27 INFO - PID 9905 | 11:25:29 INFO - PID 9905 | Cycle 1(1): loaded http://localhost:46226/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:46226/tests/kraken/driver.html?testName=audio-dft) 11:25:30 INFO - PID 9905 | RSS: Main: 180801536 11:25:30 INFO - PID 9905 | 11:25:33 INFO - PID 9905 | Cycle 1(1): loaded http://localhost:46226/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:46226/tests/kraken/driver.html?testName=audio-fft) 11:25:34 INFO - PID 9905 | RSS: Main: 174686208 11:25:34 INFO - PID 9905 | 11:25:36 INFO - PID 9905 | Cycle 1(1): loaded http://localhost:46226/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:46226/tests/kraken/driver.html?testName=audio-oscillator) 11:25:36 INFO - PID 9905 | RSS: Main: 175394816 11:25:36 INFO - PID 9905 | 11:25:39 INFO - PID 9905 | Cycle 1(1): loaded http://localhost:46226/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:46226/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:25:39 INFO - PID 9905 | RSS: Main: 175521792 11:25:39 INFO - PID 9905 | 11:25:42 INFO - PID 9905 | Cycle 1(1): loaded http://localhost:46226/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:46226/tests/kraken/driver.html?testName=imaging-darkroom) 11:25:43 INFO - PID 9905 | RSS: Main: 176975872 11:25:43 INFO - PID 9905 | 11:25:47 INFO - PID 9905 | Cycle 1(1): loaded http://localhost:46226/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:46226/tests/kraken/driver.html?testName=imaging-desaturate) 11:25:47 INFO - PID 9905 | RSS: Main: 176926720 11:25:47 INFO - PID 9905 | 11:25:50 INFO - PID 9905 | Cycle 1(1): loaded http://localhost:46226/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:46226/tests/kraken/driver.html?testName=json-parse-financial) 11:25:51 INFO - PID 9905 | RSS: Main: 177377280 11:25:51 INFO - PID 9905 | 11:25:52 INFO - PID 9905 | Cycle 1(1): loaded http://localhost:46226/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:46226/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:25:53 INFO - PID 9905 | RSS: Main: 177291264 11:25:53 INFO - PID 9905 | 11:25:55 INFO - PID 9905 | Cycle 1(1): loaded http://localhost:46226/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:46226/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:25:56 INFO - PID 9905 | RSS: Main: 177164288 11:25:56 INFO - PID 9905 | 11:25:58 INFO - PID 9905 | Cycle 1(1): loaded http://localhost:46226/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:46226/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:25:58 INFO - PID 9905 | RSS: Main: 177311744 11:25:58 INFO - PID 9905 | 11:26:01 INFO - PID 9905 | Cycle 1(1): loaded http://localhost:46226/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:46226/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:26:02 INFO - PID 9905 | RSS: Main: 177635328 11:26:02 INFO - PID 9905 | 11:26:05 INFO - PID 9905 | Cycle 1(1): loaded http://localhost:46226/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:46226/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:26:06 INFO - PID 9905 | RSS: Main: 177704960 11:26:06 INFO - PID 9905 | 11:26:07 INFO - PID 9905 | Cycle 1(1): loaded http://localhost:46226/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:46226/tests/kraken/driver.html?testName=ai-astar) 11:26:08 INFO - PID 9905 | RSS: Main: 178864128 11:26:08 INFO - PID 9905 | 11:26:08 INFO - PID 9905 | __start_tp_report 11:26:08 INFO - PID 9905 | _x_x_mozilla_page_load 11:26:08 INFO - PID 9905 | _x_x_mozilla_page_load_details 11:26:08 INFO - PID 9905 | |i|pagename|runs| 11:26:08 INFO - PID 9905 | |0;ai-astar;99;119;103;115;107;114;108;109;108;113 11:26:08 INFO - PID 9905 | |1;audio-beat-detection;148;119;150;166;123;145;151;123;177;120 11:26:08 INFO - PID 9905 | |2;audio-dft;160;167;169;171;163;168;170;166;160;164 11:26:08 INFO - PID 9905 | |3;audio-fft;74;74;74;170;77;75;73;75;153;76 11:26:08 INFO - PID 9905 | |4;audio-oscillator;87;79;131;78;84;79;135;88;79;138 11:26:08 INFO - PID 9905 | |5;imaging-gaussian-blur;120;114;113;114;113;113;116;117;115;117 11:26:08 INFO - PID 9905 | |6;imaging-darkroom;148;148;148;147;147;148;150;159;156;148 11:26:08 INFO - PID 9905 | |7;imaging-desaturate;94;93;94;94;93;96;93;94;96;93 11:26:08 INFO - PID 9905 | |8;json-parse-financial;53;53;53;53;56;52;56;60;52;53 11:26:08 INFO - PID 9905 | |9;json-stringify-tinderbox;57;57;57;59;56;56;57;62;63;56 11:26:08 INFO - PID 9905 | |10;stanford-crypto-aes;84;75;78;74;73;73;74;78;73;74 11:26:08 INFO - PID 9905 | |11;stanford-crypto-ccm;129;133;127;118;117;121;124;119;125;158 11:26:08 INFO - PID 9905 | |12;stanford-crypto-pbkdf2;179;181;166;168;180;178;169;176;171;172 11:26:08 INFO - PID 9905 | |13;stanford-crypto-sha256-iterative;67;67;63;69;70;64;61;69;65;67 11:26:08 INFO - PID 9905 | __end_tp_report 11:26:08 INFO - PID 9905 | __start_cc_report 11:26:08 INFO - PID 9905 | _x_x_mozilla_cycle_collect,950 11:26:08 INFO - PID 9905 | __end_cc_report 11:26:08 INFO - PID 9905 | __startTimestamp1503512768041__endTimestamp 11:26:08 INFO - PID 9905 | 11:26:08 INFO - PID 9905 | ------- Summary: start ------- 11:26:08 INFO - PID 9905 | Number of tests: 14 11:26:08 INFO - PID 9905 | 11:26:08 INFO - PID 9905 | [#0] ai-astar Cycles:10 Average:109.50 Median:113.50 stddev:5.93 (5.2%) stddev-sans-first:4.92 11:26:08 INFO - PID 9905 | Values: 99.0 119.0 103.0 115.0 107.0 114.0 108.0 109.0 108.0 113.0 11:26:08 INFO - PID 9905 | 11:26:08 INFO - PID 9905 | [#1] audio-beat-detection Cycles:10 Average:142.20 Median:149.00 stddev:20.35 (13.7%) stddev-sans-first:21.47 11:26:08 INFO - PID 9905 | Values: 148.0 119.0 150.0 166.0 123.0 145.0 151.0 123.0 177.0 120.0 11:26:08 INFO - PID 9905 | 11:26:08 INFO - PID 9905 | [#2] audio-dft Cycles:10 Average:165.80 Median:167.50 stddev:3.94 (2.4%) stddev-sans-first:3.57 11:26:08 INFO - PID 9905 | Values: 160.0 167.0 169.0 171.0 163.0 168.0 170.0 166.0 160.0 164.0 11:26:08 INFO - PID 9905 | 11:26:08 INFO - PID 9905 | [#3] audio-fft Cycles:10 Average:92.10 Median:74.50 stddev:36.81 (49.4%) stddev-sans-first:38.46 11:26:08 INFO - PID 9905 | Values: 74.0 74.0 74.0 170.0 77.0 75.0 73.0 75.0 153.0 76.0 11:26:08 INFO - PID 9905 | 11:26:08 INFO - PID 9905 | [#4] audio-oscillator Cycles:10 Average:97.80 Median:79.00 stddev:25.73 (32.6%) stddev-sans-first:26.99 11:26:08 INFO - PID 9905 | Values: 87.0 79.0 131.0 78.0 84.0 79.0 135.0 88.0 79.0 138.0 11:26:08 INFO - PID 9905 | 11:26:08 INFO - PID 9905 | [#5] imaging-gaussian-blur Cycles:10 Average:115.20 Median:115.50 stddev:2.30 (2.0%) stddev-sans-first:1.66 11:26:08 INFO - PID 9905 | Values: 120.0 114.0 113.0 114.0 113.0 113.0 116.0 117.0 115.0 117.0 11:26:08 INFO - PID 9905 | 11:26:08 INFO - PID 9905 | [#6] imaging-darkroom Cycles:10 Average:149.90 Median:148.00 stddev:4.15 (2.8%) stddev-sans-first:4.34 11:26:08 INFO - PID 9905 | Values: 148.0 148.0 148.0 147.0 147.0 148.0 150.0 159.0 156.0 148.0 11:26:08 INFO - PID 9905 | 11:26:08 INFO - PID 9905 | [#7] imaging-desaturate Cycles:10 Average:94.00 Median:94.00 stddev:1.15 (1.2%) stddev-sans-first:1.22 11:26:08 INFO - PID 9905 | Values: 94.0 93.0 94.0 94.0 93.0 96.0 93.0 94.0 96.0 93.0 11:26:08 INFO - PID 9905 | 11:26:08 INFO - PID 9905 | [#8] json-parse-financial Cycles:10 Average:54.10 Median:53.00 stddev:2.51 (4.7%) stddev-sans-first:2.64 11:26:08 INFO - PID 9905 | Values: 53.0 53.0 53.0 53.0 56.0 52.0 56.0 60.0 52.0 53.0 11:26:08 INFO - PID 9905 | 11:26:08 INFO - PID 9905 | [#9] json-stringify-tinderbox Cycles:10 Average:58.00 Median:57.00 stddev:2.54 (4.5%) stddev-sans-first:2.67 11:26:08 INFO - PID 9905 | Values: 57.0 57.0 57.0 59.0 56.0 56.0 57.0 62.0 63.0 56.0 11:26:08 INFO - PID 9905 | 11:26:08 INFO - PID 9905 | [#10] stanford-crypto-aes Cycles:10 Average:75.60 Median:74.50 stddev:3.50 (4.7%) stddev-sans-first:2.00 11:26:08 INFO - PID 9905 | Values: 84.0 75.0 78.0 74.0 73.0 73.0 74.0 78.0 73.0 74.0 11:26:08 INFO - PID 9905 | 11:26:08 INFO - PID 9905 | [#11] stanford-crypto-ccm Cycles:10 Average:127.10 Median:126.00 stddev:11.99 (9.5%) stddev-sans-first:12.70 11:26:08 INFO - PID 9905 | Values: 129.0 133.0 127.0 118.0 117.0 121.0 124.0 119.0 125.0 158.0 11:26:08 INFO - PID 9905 | 11:26:08 INFO - PID 9905 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:174.00 Median:177.00 stddev:5.46 (3.1%) stddev-sans-first:5.48 11:26:08 INFO - PID 9905 | Values: 179.0 181.0 166.0 168.0 180.0 178.0 169.0 176.0 171.0 172.0 11:26:08 INFO - PID 9905 | 11:26:08 INFO - PID 9905 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.20 Median:67.00 stddev:2.90 (4.3%) stddev-sans-first:3.06 11:26:08 INFO - PID 9905 | Values: 67.0 67.0 63.0 69.0 70.0 64.0 61.0 69.0 65.0 67.0 11:26:08 INFO - PID 9905 | -------- Summary: end -------- 11:26:08 INFO - PID 9905 | 11:26:08 INFO - PID 9905 | 11:26:08 INFO - PID 9905 | ###!!! [Parent][MessageChannel] Error: (msgtype=0x150081,name=PBrowser::Msg_Destroy) Closed channel: cannot send/recv 11:26:08 INFO - PID 9905 | 11:26:08 INFO - PID 9905 | 11:26:08 INFO - PID 9905 | ###!!! [Child][MessageChannel] Error: (msgtype=0x150001,name=PBrowser::Msg_AsyncMessage) Closed channel: cannot send/recv 11:26:08 INFO - PID 9905 | 11:26:08 INFO - PID 9905 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 11:26:08 INFO - TEST-INFO | 9905: exit 0 11:26:08 INFO - TEST-OK | kraken | took 62394ms 11:26:08 INFO - SUITE-END | took 1175s 11:26:09 INFO - Completed test suite (00:19:35) 11:26:09 INFO - javascript benchmark 11:26:09 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8515.563362401595, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3244.4160051190793, 3262.983685081574, 3272.7545434092417, 3293.440115180419, 3309.4704847224434, 6177.505799536038, 6199.690015499224, 6230.1900752902175, 6243.750249990001, 6255.0, 6093.817185484442, 6167.198264225655, 6189.628622282667, 6197.535184861143, 6226.968865155679, 5710.457506536873, 5715.228444160048, 5729.512991395715, 5745.683987380692, 5763.1355296705415, 5720.513756330717, 5755.280589926259, 5770.480656740892, 5801.0, 5841.678707671076, 5748.482636562709, 5832.737526811283, 5837.44544268296, 5843.590948633576, 5848.1812546243345, 5515.806946756844, 5715.628484148517, 5731.111677689964, 5767.192593036999, 5773.076307790754, 5608.327000759894, 5609.186667933127, 5627.155926611, 5671.234383358235, 5672.659640421588, 6043.48912771807, 6078.756849726005, 6192.783252586183, 6207.937920620826, 6215.316315205324, 6544.640044797582, 6550.475961923034, 6571.474282057424, 6658.533902626818, 6693.46452283821, 6688.531802773808, 6706.798796036127, 6780.694868730919, 6803.251642319341, 6808.931910680879, 6115.7859474918605, 6142.477889379364, 6169.722362493699, 6232.0963460298, 6253.0, 6677.198736151693, 6829.556078854858, 6846.144231971004, 6869.244383117853, 6892.241853396123, 6421.101045853584, 6556.3443655634055, 6556.803295901131, 6568.441682457044, 6617.735290588419, 6671.86656266872, 6701.765438209639, 6729.966350168218, 6745.8650826983185, 6755.324467553303, 6614.272430032693, 6615.37153970372, 6627.900581491282, 6709.161354830646, 6739.292374300726, 6591.802245932629, 6670.733170673216, 6671.432928201158, 6676.551996836656, 6720.059191713164, 5302.0, 5307.495787900143, 5310.6813591184655, 5313.707746074003, 5318.468153184728, 4623.029163875556, 4679.251319788886, 4702.130105930414, 4737.218358970731, 4743.146233677902, 5827.621204621686, 5870.706464676835, 5902.2622172228475, 5910.468057874812, 5912.46787789101, 6723.495737819585, 6733.831654208684, 6745.763898263537, 6785.728570857209, 6816.488763342769, 5699.116636921284, 5764.452377024176, 5799.3620701722775, 5838.7080645967535, 5848.795292164754, 5766.365699773021, 5777.364489906191, 5786.826395208066, 5792.189093526909, 5794.739236734357, 6265.0, 6269.247690277196, 6275.529335299871, 6369.0, 6369.968150159312, 6586.407223349922, 6608.8347791305605, 6688.933110669026, 6692.59844409337, 6701.497387696039, 6319.557630965788, 6331.335209803088, 6332.936670633235, 6338.366163383625, 6346.650934198663, 6574.342565743387, 6636.27001029896, 6639.136912201383, 6643.800685979429, 6670.166229221348, 6707.3292670732535, 6727.360900714424, 6734.4612431004425, 6811.557248778813, 6812.727490900308, 6341.460975817107, 6475.481961442979, 6504.869902602016, 6589.703463344257, 6596.406323430914, 6425.228972523327, 6450.258220304538, 6524.021396790519, 6524.641144737085, 6527.11883895668, 6311.684415779285, 6403.135576697273, 6417.7753778617525, 6427.228732552124, 6501.6099034056215, 6493.123428337114, 6513.2835388108215, 6546.672666366568, 6547.541672082908, 6548.47612191014, 6304.275008374096, 6304.306526282014, 6329.461995730415, 6404.839879002876, 6422.26143993428], "value": 6090.90216954078, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [770.3836930455637, 807.903051633804, 815.6125840225892, 849.9320054395647, 855.3072011670544, 39001.80499097504, 39825.0043748906, 39930.60069399305, 39959.0, 40036.39945400821, 36031.639683603156, 36425.453618195745, 36425.81787091061, 36478.27043459129, 36482.087947801316, 6884.345987131214, 6979.546329488592, 6986.545874518166, 6988.930110698879, 6999.475039372042, 6878.58728476293, 6948.826279343031, 6953.304669533057, 6955.965220173917, 6956.1652601687865, 6935.445164386837, 7611.200823913492, 7762.0, 7804.414668899827, 7808.4924479908905, 7700.961495192516, 7764.145943946161, 7768.145503994556, 7770.805729856742, 7779.72770953014, 7506.587137707424, 7625.237476252386, 7732.1108072571815, 7732.922670773332, 7734.110577283628, 36962.26075478502, 37199.44200836989, 37354.06614834624, 37382.62617373819, 37398.25203495915, 3477.791332520057, 3488.7383446241633, 3510.5611798525183, 3517.56030496188, 3519.964800351989, 30637.0, 30716.692833071607, 30839.537406938915, 30862.537061944087, 30934.690653093407, 5145.922811157836, 5181.844544663666, 5185.144451165553, 5188.533032027136, 5204.115300398941, 183719.08140459345, 185328.0, 185806.0, 187629.0, 198328.99999999854, 46412.53587464149, 47075.76462117668, 47338.0, 47389.0, 47411.28883066757, 48703.0, 48897.0, 49050.264246036335, 49091.263631045564, 49110.75444622754, 13502.459901603826, 13573.04988650785, 13575.321233938264, 13647.454101836014, 13653.590392288248, 10942.726431839108, 10970.835437468444, 10979.231453798158, 10983.286086404358, 11002.0, 13238.669033274053, 13258.0, 13269.0, 13285.0, 13496.257705826274, 5450.683459529684, 5556.749946252428, 5564.8330550083565, 5567.721613919288, 5586.0, 993.8608594796734, 996.461910568285, 1002.9949850250848, 1014.3457469931852, 1014.8376259798545, 22375.77624223737, 22735.204267850877, 22753.544929101325, 22806.42983925382, 22896.427589310402, 1067.9839802402971, 1074.3768614203743, 1094.534822700365, 1100.2518287564374, 1100.4112799652148, 11791.0, 12014.63956081319, 12125.0, 15660.530184094496, 15665.45170919035, 238227.0, 239238.0, 240305.0, 240345.0, 240358.0, 55055.522501486725, 55079.44920550823, 55545.444545554026, 55615.16577251344, 55684.0, 1388.1046724862408, 1404.2346920928119, 1411.5624156511515, 1416.5750274917484, 1417.3905220755175, 26418.867905660347, 26678.066267680537, 26941.0, 26973.730262697907, 27611.861940690167, 34679.30641387209, 34889.0, 35226.823865880506, 35263.64736352706, 35281.82359088188, 212394.0, 213865.0, 214327.0, 214618.0, 215695.0, 32815.835920820246, 33000.504992424656, 33619.0, 33632.66367336393, 33759.4936075964, 40440.0, 41705.0, 42212.577874220864, 42243.3663495054, 42480.36279455749, 30710.232244194074, 31026.0, 31207.84396078005, 31222.21944451407, 31225.84387078141, 29986.0, 30549.694503054685, 30864.382712345177, 30884.382312354075, 30953.690463095983, 34743.65256347505, 34803.303933921685, 35126.82436587903, 35414.291714165054, 35441.64558354383, 29719.25701857471, 29730.0, 30117.397652047275, 30272.697273026988, 30565.54151687771, 22190.131168019987, 22575.887120564294, 22844.657330140395, 22929.0, 23067.22039695107], "value": 16698.68876127915, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [549.3654828672882, 550.7466565379925, 552.748499432758, 557.436988641472, 572.5333852909878, 21774.455638609044, 21813.23653672122, 22590.54818903621, 22592.54814903701, 22600.43498912526, 24852.384595001313, 25525.872370638168, 25553.23340299794, 25589.0, 25601.871990640022, 7105.076340075783, 7257.129144502667, 7263.854722905538, 7274.527155734887, 7289.599072051035, 6534.215894092692, 7094.929050709478, 7148.642567871611, 7159.427245820322, 7166.104236970379, 7122.821929451753, 7157.498975071747, 7164.85670286594, 7166.677499512534, 7171.318724721144, 7167.964160179192, 7170.8565828683395, 7174.103237095389, 7181.856362872713, 7195.208527062019, 7017.193022802341, 7035.788926332167, 7044.682989265495, 7046.6828992695455, 7047.083879095736, 30196.396072078434, 30950.0714978551, 31118.222044448845, 31135.22161945947, 31159.53260701091, 2074.471009892483, 2101.0, 2103.253345062496, 2104.2635077722825, 2113.3131732187103, 20462.181512739473, 21186.36440906775, 21206.257780977747, 21208.151673933025, 21234.5753084939, 2483.2177863972793, 2494.875256237199, 2537.644729737838, 2563.192594332798, 2618.5417551928335, 137508.31245843807, 140982.0, 141338.29330853486, 141512.0, 141587.0, 19249.32627358036, 20848.583028339348, 21010.47473813167, 21431.0, 22163.889180553993, 22451.887740561193, 23219.419514512272, 23376.181833635743, 23378.415539611648, 41685.79157104195, 9263.397879137834, 9380.577873995686, 9486.667966621135, 9508.429494230368, 9601.47191904452, 8486.660533578588, 8537.829243415097, 8602.31181505478, 8625.91374086251, 8678.609462574199, 8908.777280567909, 9005.819883602422, 9078.500682462529, 9115.908840911507, 9496.097870702271, 2562.6540417043834, 2574.8970041198518, 2578.3425226567106, 2683.5974603809586, 2735.2478068531314, 939.478589382899, 958.5399008475831, 965.4255717847869, 967.0281367225892, 987.0, 19353.612927741648, 19391.3213037543, 19479.902600487192, 19850.305239316844, 19980.50048748764, 1005.1355833982769, 1019.592163134752, 1033.9017793309624, 1038.127972503101, 1043.7703705184847, 10747.689246811973, 10784.0, 10848.67453976382, 11050.613228537124, 11168.888311116785, 511498.0, 511664.0, 547460.0, 547831.0, 556893.0, 115147.42426287815, 116986.0, 119047.0, 119149.0, 124667.0, 1197.4192516629428, 1215.1736818963013, 1249.631358749171, 1254.4605819497522, 1255.6672481792332, 19170.808291916903, 19267.421977340702, 19295.614087718448, 19588.8452270253, 19937.302194423126, 52359.47640523546, 53062.2040669398, 54671.17993230025, 56003.43996559982, 56094.0, 65261.0, 68125.65937170283, 68403.3159668397, 68462.31537684759, 68615.65692171507, 13960.092593981359, 14443.78334325007, 14604.12375257488, 14668.853311466748, 14675.972681912164, 22853.428664283525, 22879.0, 22884.88557557268, 22901.19845805389, 23020.884895575415, 18220.90889545544, 18673.53316167107, 18694.813051869307, 18716.906415467834, 18841.15214815309, 15846.603834903759, 15989.920050399674, 16366.672666546841, 16403.67192656164, 16521.421750238685, 18511.0, 18992.810071899105, 19194.424167275003, 19209.615807683487, 19219.039048047263, 14333.140011599337, 14359.066660667024, 14436.0, 14498.0, 14506.0, 17002.319907203575, 17130.057846818545, 17137.571560711083, 18307.267709292013, 18484.907575462035], "value": 12314.090438247487, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1257.6164269897681, 1312.6980794417284, 1336.3585478970087, 1337.284552764271, 1348.6291269900769, 14216.715665686681, 14651.706965860676, 14837.183954882477, 14917.179555124463, 14929.178895160761, 15337.463188788395, 15438.84561154388, 15565.37738490459, 15580.065196088242, 15601.843981560181, 2634.1307368568328, 2694.6631671041023, 2697.932551686204, 2699.8650067496646, 2708.79684023698, 2492.5513407586627, 2598.8440693558446, 2660.7472290132505, 2661.095227622608, 2661.7737492313177, 2704.418550011747, 2706.3098909777977, 2719.415325704973, 2720.795940304475, 2724.82288651238, 2686.1135825177644, 2709.647745793054, 2712.0643378034547, 2713.9728602713917, 2717.9592306115424, 2595.922122336333, 2647.721989191146, 2653.2173008962404, 2656.8538730369823, 2657.162993657011, 14281.357338919774, 14516.129032258099, 14516.491922782652, 14520.70958580833, 14526.927365363106, 7784.221577842227, 8039.919600804034, 8053.798655033613, 8053.798655033613, 8059.395545334065, 5180.792768289301, 5359.196120581944, 5448.0, 5463.399026107125, 5472.0, 1824.1517694272227, 1869.5139263791377, 1875.7936626971023, 1914.741509896174, 1915.0807612346014, 24343.87828060866, 24486.877565612234, 24565.508689826103, 24600.753992460024, 24609.63085553718, 6577.34226577348, 6585.506087043491, 6593.6703164841565, 6745.2242992056545, 6746.325367463214, 16393.34426622922, 16410.671786564202, 16413.1793410329, 16416.589585260226, 16420.096894670667, 7441.627918604048, 7570.810729731801, 7574.772756817304, 7577.128630207597, 7585.127710313384, 6134.78528251509, 6921.204061532988, 6959.826004349932, 6994.370506654425, 7034.824129396806, 4872.317875497433, 5126.974365128151, 5283.392409872837, 5308.654937429054, 5319.28189694394, 1505.759078547449, 1555.113585256393, 1561.8360072192256, 1567.4592265668325, 1579.7077540655016, 892.7277180459893, 908.4276905549593, 910.544727636182, 919.2048877720723, 926.9988412514468, 8167.591620418955, 8528.53093079874, 8612.48325100496, 8654.394192406597, 8655.56722163902, 967.1923943507251, 994.4977786218059, 995.5520015992832, 1012.6455740490769, 1013.640157744005, 5166.535011848877, 5262.236975638511, 5362.785488580491, 5394.379646340721, 5399.649022813504, 19460.80539194618, 20049.09779059946, 20286.188552458032, 20436.897815510827, 20452.897735511226, 19512.0, 20034.499137521387, 20058.197672093243, 20157.294494692615, 20174.193032278545, 10547.736306592244, 10770.73073173177, 10809.567617295377, 10911.83632245517, 10981.505832237408, 8118.2693557580105, 8480.151984801718, 8489.787755306166, 8575.614097365758, 8782.0, 17214.741778873577, 17462.82537174612, 17688.55778605494, 17817.643647127243, 18070.277188912296, 17478.475645730647, 17902.28390864403, 17961.73057404114, 18093.819061809212, 18182.818171818642, 11394.715132121763, 11728.88271117312, 11744.236624619372, 11752.11859110553, 11793.115516336138, 12089.516419343128, 12392.256464612152, 12534.059945503941, 13186.736265274449, 13575.728485430038, 10328.122109620766, 10436.060754532129, 10525.263231574023, 10538.051575358255, 10676.252662313564, 10706.571737130738, 10723.571057157938, 10909.18181136402, 10921.781564368826, 10965.396903170402, 9726.076022777825, 9828.4102953823, 9915.950420247853, 9919.950400247953, 9920.0, 7064.522707039002, 7090.113735783028, 7199.327333064756, 7210.2789721027475, 7263.201047884834, 7273.745418910313, 7360.0063991360485, 7371.926280737124, 7455.254474552501, 7498.512596681198], "value": 6538.693751602589, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [490.5323497627212, 490.7300984458548, 514.6140394703972, 522.386196219442, 528.2208742105393, 6286.339934306895, 6344.1752572165615, 6373.585716928396, 6383.58506697065, 6412.935870641292, 6290.245170579526, 6332.936670633292, 6336.366363363662, 6353.237611486628, 6357.1417858589075, 5189.974050129763, 5200.427952925175, 5204.843854684346, 5217.608679349045, 5237.685738855681, 5096.923546146811, 5118.0, 5210.609204309673, 5228.215767634866, 5249.031613145071, 4875.146849301375, 4961.578265847407, 4966.453690094087, 4980.750962451881, 5016.523430274136, 4993.226049962262, 5001.949980500185, 5016.874578135539, 5018.222175562793, 5024.698518088926, 4371.388005679208, 4452.888677783049, 4491.416115904912, 4495.752733599651, 4509.301058335963, 6097.054956481708, 6196.659183744892, 6209.0, 6220.906686399708, 6229.221347331583, 5657.8585535361535, 5744.368119506851, 5776.0, 5777.706707176911, 5780.421957804228, 6658.667066646648, 6674.06563081169, 6674.2658307586125, 6674.733010679567, 6679.499037572153, 4919.777545707568, 4936.555709986083, 4940.975295123501, 4943.777530011158, 4946.752662366867, 6730.427913627299, 6878.7248510060035, 6932.72269109235, 6938.757143499954, 6973.267806880255, 5025.14572522672, 5027.597792176617, 5032.547070763576, 5042.394912610437, 5054.772535235923, 5093.0, 5104.795808167706, 5115.258287548285, 5116.155834287375, 5118.897622047538, 5643.689597072201, 5702.151048042555, 5706.229658995982, 5730.856728581819, 5756.0, 6617.437517810944, 6671.766488172891, 6683.331666833375, 6688.86622267552, 6703.156631926162, 1722.0786879019665, 1727.9136043197789, 1736.661351036561, 1742.7995780485153, 1750.6761249168944, 1164.6040346282305, 1198.328935795957, 1217.391304347826, 1234.4444999750149, 1238.8823061809114, 5805.187273781674, 5813.418658134153, 5864.354920958691, 5864.67744274069, 5917.142014407973, 6760.301590394629, 6780.559263647847, 6820.590764554044, 6846.931530684729, 6898.241193468714, 5778.306603207642, 5820.796272130455, 5854.238948936696, 5857.560682948796, 5873.2658417697785, 3588.8564457421935, 3601.549806274216, 3619.6561326673923, 3623.7282203834816, 3654.2326111516877, 6369.522285828489, 6370.458511026522, 6402.679866006774, 6415.454686351619, 6476.125723027425, 6906.374153569316, 6947.444204463631, 6968.372846443743, 6976.616286104211, 7006.649667516604, 6060.515158787286, 6394.616323020634, 6414.807555773335, 6421.335145914393, 6459.418652321314, 6772.898406523807, 6784.185897692309, 6787.457003439614, 6822.0, 6844.863102738017, 6718.294579069127, 6722.630255335808, 6730.0, 6737.730490780314, 6779.35596118368, 6399.712012959335, 6412.070249813844, 6441.613503189824, 6451.1290975717675, 6465.741370345134, 4932.778024988812, 4946.233333833262, 4959.9008019838675, 5025.447200807835, 5052.090623687772, 6546.705398256994, 6661.134052573135, 6697.51266651335, 6733.023711561894, 6769.0, 6528.335274504971, 6550.246721626883, 6586.176727909012, 6600.768973086111, 6613.140291762233, 6539.934600653933, 6556.246031706415, 6556.770513032021, 6560.114384558024, 6602.702878370389, 6434.227892652912, 6441.71012304438, 6503.6097834130105, 6518.771842985473, 6562.77030303937, 6611.0, 6649.135612370361, 6712.93287067123, 6738.46092312604, 6763.154605674291, 6417.486601071996, 6476.935230647633, 6497.577657452251, 6515.641639709862, 6523.739050438119], "value": 5097.761841455897, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [866.3718803867197, 882.9426087304325, 901.7159594727665, 916.0564618443002, 920.3189639666649, 18120.27518899244, 19143.32998345058, 19201.327953521628, 19245.615087698272, 22440.214592489265, 20394.286199983002, 20746.273880414188, 21042.053107610154, 21132.15471381147, 21149.788502114974, 916.4730280088942, 939.2908354192575, 943.8489841625342, 943.9905600944006, 945.0124619772355, 889.2930120554142, 940.8682784410188, 946.981060378792, 960.5101398286854, 963.6771681486675, 1001.9298649094567, 1009.530568285747, 1012.9392236465799, 1013.8124446977296, 1014.4927536231884, 999.5502024089153, 1000.104906109032, 1000.4897502273857, 1000.9399436033862, 1001.4692213127055, 738.2986163145034, 738.8337624034549, 738.9298016688459, 739.3235189801379, 739.3973911262304, 19164.233430662756, 19620.50948726279, 19907.0, 19925.501862453555, 20033.79966200334, 21258.0, 21306.786932130635, 21785.0, 21786.237481688222, 21881.12475500978, 15520.14639194855, 15911.761323580156, 15991.28039238237, 16015.599610009844, 16125.274362653709, 3559.288142371536, 3566.983409728241, 3587.264610754789, 3617.656322649344, 3619.855205791765, 124998.0, 125691.0, 127095.0, 127857.0, 128387.35806321002, 16231.756523651919, 16554.255058522154, 16820.0748958806, 17125.48623541296, 17245.0, 29840.40319193604, 30206.84896575503, 30340.69659303423, 30364.089077327273, 30521.38957220843, 7830.686772529035, 8160.0, 8161.959190204011, 9026.548672566345, 9039.638414463348, 4322.113966636832, 4385.736855788663, 4398.208322501981, 4415.735055896656, 4417.050334178167, 4895.485973972753, 4969.27945447908, 5027.2207807789855, 5060.3927528696795, 5078.263651770472, 970.2771435280761, 976.7362812040851, 994.1549682769588, 996.4768496539375, 999.4053538144792, 606.8786242751468, 671.2113266911359, 693.0470602920983, 711.0010435338357, 711.1288671377624, 11247.212695111428, 11264.549418023187, 11781.941090294666, 13363.33183340829, 14146.858531414555, 674.6356967237637, 692.1106378303956, 696.8710788504143, 699.5068476723898, 707.9752208672671, 5522.447755224445, 5931.851703707442, 6144.07838824171, 6178.011518157074, 6181.0, 106151.0, 108673.0, 109897.0, 111370.44314778375, 112956.43521782338, 97713.5114324438, 99465.0, 99614.0, 100049.49975250078, 104867.0, 87620.0, 89348.5532572333, 90096.0, 90243.54878225568, 92333.0, 11859.644210673694, 12512.749745004867, 12528.74942501163, 12717.936410317889, 13095.541656041993, 39954.80022599868, 40012.1997560053, 40574.0, 41424.58575414207, 42451.3632295522, 68438.65780671065, 70497.64751176417, 72036.0, 73576.26423735694, 74144.0, 17893.0, 18066.36767713124, 18153.546161346072, 18167.27330906749, 18541.536461588566, 18699.906500467412, 19094.331698391044, 19179.520511987314, 19202.231910723414, 19247.90376048167, 20070.0, 20086.296979605642, 20266.18935242574, 20321.390358289274, 20448.182072717518, 17472.475825725247, 18460.353887614405, 18590.628187436447, 18776.81223187805, 19267.71098433553, 17810.821891781434, 17928.551786205448, 17986.91006544959, 18231.544211394823, 18475.63048738991, 12538.373081345713, 12632.178908370926, 12731.55439559611, 12869.613911582668, 12959.611211663665, 13772.586822395344, 14117.43530258778, 14200.928995354958, 14323.427062917366, 14976.775348370002], "value": 9133.089236903656, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1521.4999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 119.0, 103.0, 115.0, 107.0, 114.0, 108.0, 109.0, 108.0, 113.0], "value": 109.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 119.0, 150.0, 166.0, 123.0, 145.0, 151.0, 123.0, 177.0, 120.0], "value": 142.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 167.0, 169.0, 171.0, 163.0, 168.0, 170.0, 166.0, 160.0, 164.0], "value": 165.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 74.0, 170.0, 77.0, 75.0, 73.0, 75.0, 153.0, 76.0], "value": 92.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 79.0, 131.0, 78.0, 84.0, 79.0, 135.0, 88.0, 79.0, 138.0], "value": 97.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [120.0, 114.0, 113.0, 114.0, 113.0, 113.0, 116.0, 117.0, 115.0, 117.0], "value": 115.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 148.0, 148.0, 147.0, 147.0, 148.0, 150.0, 159.0, 156.0, 148.0], "value": 149.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 93.0, 94.0, 94.0, 93.0, 96.0, 93.0, 94.0, 96.0, 93.0], "value": 94.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 53.0, 53.0, 53.0, 56.0, 52.0, 56.0, 60.0, 52.0, 53.0], "value": 54.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 57.0, 57.0, 59.0, 56.0, 56.0, 57.0, 62.0, 63.0, 56.0], "value": 58.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 75.0, 78.0, 74.0, 73.0, 73.0, 74.0, 78.0, 73.0, 74.0], "value": 75.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [129.0, 133.0, 127.0, 118.0, 117.0, 121.0, 124.0, 119.0, 125.0, 158.0], "value": 127.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [179.0, 181.0, 166.0, 168.0, 180.0, 178.0, 169.0, 176.0, 171.0, 172.0], "value": 174.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 63.0, 69.0, 70.0, 64.0, 61.0, 69.0, 65.0, 67.0], "value": 66.2, "unit": "score"}]}]} 11:26:09 INFO - Return code: 0 11:26:09 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:26:09 INFO - # TBPL SUCCESS # 11:26:09 INFO - Running post-action listener: _package_coverage_data 11:26:09 INFO - Running post-action listener: _resource_record_post_action 11:26:09 INFO - [mozharness: 2017-08-23 18:26:09.329008Z] Finished run-tests step (success) 11:26:09 INFO - Running post-run listener: _resource_record_post_run 11:26:09 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 495616; Write bytes: 429830144; Read time: 44; Write time: 323308 11:26:09 INFO - TinderboxPrint: CPU usage
13.1% 11:26:09 INFO - TinderboxPrint: I/O read bytes / time
495,616 / 44 11:26:09 INFO - TinderboxPrint: I/O write bytes / time
429,830,144 / 323,308 11:26:09 INFO - TinderboxPrint: CPU idle
8,268.0 (86.8%) 11:26:09 INFO - TinderboxPrint: CPU user
1,199.5 (12.6%) 11:26:09 INFO - TinderboxPrint: Swap in / out
0 / 0 11:26:09 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 105840640; Read time: 0; Write time: 102024 11:26:09 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 11:26:09 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 495616; Write bytes: 323989504; Read time: 44; Write time: 221284 11:26:09 INFO - Running post-run listener: _upload_blobber_files 11:26:09 INFO - Blob upload gear active. 11:26:09 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:26:09 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 11:26:09 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'] 11:26:09 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 11:26:10 INFO - (blobuploader) - INFO - Open directory for files ... 11:26:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 11:26:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:26:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:26:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 11:26:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:26:11 INFO - (blobuploader) - INFO - Done attempting. 11:26:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 11:26:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:26:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:26:13 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 11:26:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:26:13 INFO - (blobuploader) - INFO - Done attempting. 11:26:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 11:26:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:26:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:26:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 11:26:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:26:14 INFO - (blobuploader) - INFO - Done attempting. 11:26:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:26:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:26:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:26:17 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:26:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:26:17 INFO - (blobuploader) - INFO - Done attempting. 11:26:17 INFO - (blobuploader) - INFO - Iteration through files over. 11:26:17 INFO - Return code: 0 11:26:17 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:26:17 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:26:17 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/394daf18a215f77ba02fd84cb04c0823fc5446f13504bdba36bb5e0e109f5d785cee26a2440192b3789a89a5509b0801c723437b2b68d521fcb8ca9d550da9a7", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f1807a9a3336877ab4ac25188acf8ed624d07d83249945178e92485fca1120f06323728846150ed23b54153aeec782a226d73a4eca80fcb6a7f1a4a50b3e8020", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/940f581e882bf53a94570f2ac3b7ab870496d463aed163f42103115e919108b629ab147e577860a10ed9a3bed2fae1940818f9b2a93cc92f9d5f67159b92c357", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d78f1b0238d00c1251dd8c365f3fda3188cfa5a2663400b3baa070602c6a6fe980faf6f96dcac3b777fb4c3cce2735a09ad86f8616d2e9ce80a9698831697108"} 11:26:17 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:26:17 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:26:17 INFO - Contents: 11:26:17 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/394daf18a215f77ba02fd84cb04c0823fc5446f13504bdba36bb5e0e109f5d785cee26a2440192b3789a89a5509b0801c723437b2b68d521fcb8ca9d550da9a7", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f1807a9a3336877ab4ac25188acf8ed624d07d83249945178e92485fca1120f06323728846150ed23b54153aeec782a226d73a4eca80fcb6a7f1a4a50b3e8020", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/940f581e882bf53a94570f2ac3b7ab870496d463aed163f42103115e919108b629ab147e577860a10ed9a3bed2fae1940818f9b2a93cc92f9d5f67159b92c357", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d78f1b0238d00c1251dd8c365f3fda3188cfa5a2663400b3baa070602c6a6fe980faf6f96dcac3b777fb4c3cce2735a09ad86f8616d2e9ce80a9698831697108"} 11:26:17 INFO - Running post-run listener: copy_logs_to_upload_dir 11:26:17 INFO - Copying logs to upload dir... 11:26:17 INFO - mkdir: /builds/slave/test/build/upload/logs 11:26:17 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1253.482731 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2017-08-23 11:26:17.773002) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-23 11:26:17.776574) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1503509401.652898-1074217580 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/394daf18a215f77ba02fd84cb04c0823fc5446f13504bdba36bb5e0e109f5d785cee26a2440192b3789a89a5509b0801c723437b2b68d521fcb8ca9d550da9a7", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f1807a9a3336877ab4ac25188acf8ed624d07d83249945178e92485fca1120f06323728846150ed23b54153aeec782a226d73a4eca80fcb6a7f1a4a50b3e8020", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/940f581e882bf53a94570f2ac3b7ab870496d463aed163f42103115e919108b629ab147e577860a10ed9a3bed2fae1940818f9b2a93cc92f9d5f67159b92c357", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d78f1b0238d00c1251dd8c365f3fda3188cfa5a2663400b3baa070602c6a6fe980faf6f96dcac3b777fb4c3cce2735a09ad86f8616d2e9ce80a9698831697108"} build_url:https://queue.taskcluster.net/v1/task/dxB5vMCrQHiaBdc7q5NgLw/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011203 build_url: 'https://queue.taskcluster.net/v1/task/dxB5vMCrQHiaBdc7q5NgLw/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/394daf18a215f77ba02fd84cb04c0823fc5446f13504bdba36bb5e0e109f5d785cee26a2440192b3789a89a5509b0801c723437b2b68d521fcb8ca9d550da9a7", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f1807a9a3336877ab4ac25188acf8ed624d07d83249945178e92485fca1120f06323728846150ed23b54153aeec782a226d73a4eca80fcb6a7f1a4a50b3e8020", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/940f581e882bf53a94570f2ac3b7ab870496d463aed163f42103115e919108b629ab147e577860a10ed9a3bed2fae1940818f9b2a93cc92f9d5f67159b92c357", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d78f1b0238d00c1251dd8c365f3fda3188cfa5a2663400b3baa070602c6a6fe980faf6f96dcac3b777fb4c3cce2735a09ad86f8616d2e9ce80a9698831697108"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-23 11:26:17.802781) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-23 11:26:17.803074) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1503509401.652898-1074217580 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004490 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-23 11:26:17.889934) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-23 11:26:17.890471) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-23 11:26:17.890988) ========= ========= Total master_lag: 0.17 =========