builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-006 starttime: 1503339676.1 results: success (0) revision: a9d372645a32b8d23d44244f351639af9d73b96a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-08-21 11:21:16.104163) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-08-21 11:21:16.104612) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-21 11:21:16.104879) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-21 11:21:16.147398) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-21 11:21:16.147715) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1503338607.495298-417619000 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-08-21 11:21:16-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 218K=0.05s 2017-08-21 11:21:16 (218 KB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.334989 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-21 11:21:16.524195) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-21 11:21:16.524554) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1503338607.495298-417619000 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016869 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-21 11:21:16.574616) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-08-21 11:21:16.574948) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev a9d372645a32b8d23d44244f351639af9d73b96a --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 a9d372645a32b8d23d44244f351639af9d73b96a --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=e31afd3c0f0de4e86ebe4d94000001b5-1503338607.495298-417619000 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-08-21 11:21:16,610 truncating revision to first 12 chars 2017-08-21 11:21:16,610 Setting DEBUG logging. 2017-08-21 11:21:16,610 attempt 1/10 2017-08-21 11:21:16,610 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/a9d372645a32?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-08-21 11:21:17,906 unpacking tar archive at: mozilla-central-a9d372645a32/testing/mozharness/ program finished with exit code 0 elapsedTime=1.646921 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-08-21 11:21:18.236925) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-21 11:21:18.237247) ========= script_repo_revision: a9d372645a32b8d23d44244f351639af9d73b96a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-21 11:21:18.237643) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-21 11:21:18.237907) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-21 11:21:18.248921) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2017-08-21 11:21:18.249327) ========= /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=e31afd3c0f0de4e86ebe4d94000001b5-1503338607.495298-417619000 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:21:18 INFO - MultiFileLogger online at 20170821 11:21:18 in /builds/slave/test 11:21:18 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:21:18 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:21:18 INFO - {'append_to_log': False, 11:21:18 INFO - 'base_work_dir': '/builds/slave/test', 11:21:18 INFO - 'blob_upload_branch': 'Firefox', 11:21:18 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:21:18 INFO - 'branch': 'Firefox', 11:21:18 INFO - 'buildbot_json_path': 'buildprops.json', 11:21:18 INFO - 'code_coverage': False, 11:21:18 INFO - 'config_files': ('talos/linux_config.py',), 11:21:18 INFO - 'default_actions': ('clobber', 11:21:18 INFO - 'read-buildbot-config', 11:21:18 INFO - 'download-and-extract', 11:21:18 INFO - 'populate-webroot', 11:21:18 INFO - 'create-virtualenv', 11:21:18 INFO - 'install', 11:21:18 INFO - 'setup-mitmproxy', 11:21:18 INFO - 'run-tests'), 11:21:18 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:21:18 INFO - 'disable_ccov_upload': False, 11:21:18 INFO - 'download_minidump_stackwalk': True, 11:21:18 INFO - 'download_symbols': 'ondemand', 11:21:18 INFO - 'enable_stylo': False, 11:21:18 INFO - 'enable_webrender': False, 11:21:18 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:21:18 INFO - 'tooltool.py': '/tools/tooltool.py', 11:21:18 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:21:18 INFO - '/tools/misc-python/virtualenv.py')}, 11:21:18 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:21:18 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:21:18 INFO - 'gecko_profile': False, 11:21:18 INFO - 'gecko_profile_interval': 0, 11:21:18 INFO - 'installer_path': 'installer.exe', 11:21:18 INFO - 'log_level': 'info', 11:21:18 INFO - 'log_name': 'talos', 11:21:18 INFO - 'log_to_console': True, 11:21:18 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:21:18 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:21:18 INFO - 'opt_config_files': (), 11:21:18 INFO - 'pip_index': False, 11:21:18 INFO - 'suite': 'dromaeojs-e10s', 11:21:18 INFO - 'system_bits': '32', 11:21:18 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:21:18 INFO - 'title': 'talos-linux64-ix-006', 11:21:18 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:21:18 INFO - 'use_talos_json': True, 11:21:18 INFO - 'verify': 'False', 11:21:18 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:21:18 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:21:18 INFO - 'work_dir': 'build'} 11:21:18 INFO - [mozharness: 2017-08-21 18:21:18.539657Z] Running clobber step. 11:21:18 INFO - Running pre-action listener: _resource_record_pre_action 11:21:18 INFO - Running main action method: clobber 11:21:18 INFO - rmtree: /builds/slave/test/build 11:21:18 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:21:19 INFO - Running post-action listener: _resource_record_post_action 11:21:19 INFO - [mozharness: 2017-08-21 18:21:19.508200Z] Finished clobber step (success) 11:21:19 INFO - [mozharness: 2017-08-21 18:21:19.508296Z] Running read-buildbot-config step. 11:21:19 INFO - Running pre-action listener: _resource_record_pre_action 11:21:19 INFO - Running main action method: read_buildbot_config 11:21:19 INFO - Using buildbot properties: 11:21:19 INFO - { 11:21:19 INFO - "project": "", 11:21:19 INFO - "product": "firefox", 11:21:19 INFO - "who": "ffxbld@noreply.mozilla.org", 11:21:19 INFO - "installer_path": "public/build/target.tar.bz2", 11:21:19 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 11:21:19 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 11:21:19 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 11:21:19 INFO - "stage_platform": "linux64-pgo", 11:21:19 INFO - "basedir": "/builds/slave/test", 11:21:19 INFO - "buildnumber": 134, 11:21:19 INFO - "platform": "ubuntu64_hw", 11:21:19 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 11:21:19 INFO - "slavebuilddir": "test", 11:21:19 INFO - "taskId": "Sg52AudwSPWGvZlUuYNrZA", 11:21:19 INFO - "branch": "mozilla-central", 11:21:19 INFO - "script_repo_revision": "production", 11:21:19 INFO - "revision": "a9d372645a32b8d23d44244f351639af9d73b96a", 11:21:19 INFO - "slavename": "talos-linux64-ix-006", 11:21:19 INFO - "repo_path": "mozilla-central" 11:21:19 INFO - } 11:21:19 INFO - Finding installer, test and symbols from parent task. 11:21:19 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Sg52AudwSPWGvZlUuYNrZA'}, attempt #1 11:21:19 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Sg52AudwSPWGvZlUuYNrZA'}, attempt #1 11:21:20 INFO - Task dependencies: dgb5MIIuQw2LKtY8dH2Fjg 11:21:20 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dgb5MIIuQw2LKtY8dH2Fjg'}, attempt #1 11:21:20 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/dgb5MIIuQw2LKtY8dH2Fjg/artifacts/public/build/target.tar.bz2 11:21:20 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/dgb5MIIuQw2LKtY8dH2Fjg/artifacts/public/build/target.test_packages.json 11:21:20 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/dgb5MIIuQw2LKtY8dH2Fjg/artifacts/public/build/target.crashreporter-symbols.zip 11:21:20 INFO - Running post-action listener: _resource_record_post_action 11:21:20 INFO - [mozharness: 2017-08-21 18:21:20.872423Z] Finished read-buildbot-config step (success) 11:21:20 INFO - [mozharness: 2017-08-21 18:21:20.872640Z] Running download-and-extract step. 11:21:20 INFO - Running pre-action listener: _resource_record_pre_action 11:21:20 INFO - Running main action method: download_and_extract 11:21:20 INFO - mkdir: /builds/slave/test/build/tests 11:21:20 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:21:20 INFO - trying https://queue.taskcluster.net/v1/task/dgb5MIIuQw2LKtY8dH2Fjg/artifacts/public/build/target.test_packages.json 11:21:20 INFO - Downloading https://queue.taskcluster.net/v1/task/dgb5MIIuQw2LKtY8dH2Fjg/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 11:21:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dgb5MIIuQw2LKtY8dH2Fjg/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 11:21:21 INFO - Downloaded 989 bytes. 11:21:21 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 11:21:21 INFO - Using the following test package requirements: 11:21:21 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 11:21:21 INFO - u'common': [u'target.common.tests.zip'], 11:21:21 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 11:21:21 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 11:21:21 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 11:21:21 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 11:21:21 INFO - u'mozbase': [u'target.common.tests.zip'], 11:21:21 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 11:21:21 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 11:21:21 INFO - u'web-platform': [u'target.common.tests.zip', 11:21:21 INFO - u'target.web-platform.tests.tar.gz'], 11:21:21 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 11:21:21 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 11:21:21 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/dgb5MIIuQw2LKtY8dH2Fjg/artifacts/public/build/target.common.tests.zip 11:21:21 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dgb5MIIuQw2LKtY8dH2Fjg/artifacts/public/build/target.common.tests.zip'}, attempt #1 11:21:21 INFO - Fetch https://queue.taskcluster.net/v1/task/dgb5MIIuQw2LKtY8dH2Fjg/artifacts/public/build/target.common.tests.zip into memory 11:21:22 INFO - Content-Length response header: 54618354 11:21:22 INFO - Bytes received: 54618354 11:21:33 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 11:21:33 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/dgb5MIIuQw2LKtY8dH2Fjg/artifacts/public/build/target.common.tests.zip 11:21:33 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dgb5MIIuQw2LKtY8dH2Fjg/artifacts/public/build/target.common.tests.zip'}, attempt #1 11:21:33 INFO - Fetch https://queue.taskcluster.net/v1/task/dgb5MIIuQw2LKtY8dH2Fjg/artifacts/public/build/target.common.tests.zip into memory 11:21:35 INFO - Content-Length response header: 54618354 11:21:35 INFO - Bytes received: 54618354 11:21:48 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/dgb5MIIuQw2LKtY8dH2Fjg/artifacts/public/build/target.talos.tests.zip 11:21:48 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dgb5MIIuQw2LKtY8dH2Fjg/artifacts/public/build/target.talos.tests.zip'}, attempt #1 11:21:48 INFO - Fetch https://queue.taskcluster.net/v1/task/dgb5MIIuQw2LKtY8dH2Fjg/artifacts/public/build/target.talos.tests.zip into memory 11:21:48 INFO - Content-Length response header: 14496256 11:21:48 INFO - Bytes received: 14496256 11:21:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:21:49 INFO - trying https://queue.taskcluster.net/v1/task/dgb5MIIuQw2LKtY8dH2Fjg/artifacts/public/build/target.tar.bz2 11:21:49 INFO - Downloading https://queue.taskcluster.net/v1/task/dgb5MIIuQw2LKtY8dH2Fjg/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 11:21:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dgb5MIIuQw2LKtY8dH2Fjg/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 11:21:50 INFO - Downloaded 63101938 bytes. 11:21:50 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/dgb5MIIuQw2LKtY8dH2Fjg/artifacts/public/build/target.tar.bz2 11:21:50 INFO - mkdir: /builds/slave/test/properties 11:21:50 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:21:50 INFO - Writing to file /builds/slave/test/properties/build_url 11:21:50 INFO - Contents: 11:21:50 INFO - build_url:https://queue.taskcluster.net/v1/task/dgb5MIIuQw2LKtY8dH2Fjg/artifacts/public/build/target.tar.bz2 11:21:50 INFO - Running post-action listener: _resource_record_post_action 11:21:50 INFO - Running post-action listener: find_tests_for_verification 11:21:50 INFO - Running post-action listener: set_extra_try_arguments 11:21:50 INFO - [mozharness: 2017-08-21 18:21:50.471249Z] Finished download-and-extract step (success) 11:21:50 INFO - [mozharness: 2017-08-21 18:21:50.471346Z] Running populate-webroot step. 11:21:50 INFO - Running pre-action listener: _resource_record_pre_action 11:21:50 INFO - Running main action method: populate_webroot 11:21:50 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:21:50 INFO - 'chromez-stylo-e10s': {'talos_options': ['--stylo'], 11:21:50 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:21:50 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:21:50 INFO - 'dromaeojs-stylo-e10s': {'talos_options': ['--stylo'], 11:21:50 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:21:50 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 11:21:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:21:50 INFO - 'g1-stylo-e10s': {'pagesets_name': 'tp5n.zip', 11:21:50 INFO - 'talos_options': ['--stylo'], 11:21:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:21:50 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 11:21:50 INFO - 'tests': ['damp', 'tps']}, 11:21:50 INFO - 'g2-stylo-e10s': {'pagesets_name': 'tp5n.zip', 11:21:50 INFO - 'talos_options': ['--stylo'], 11:21:50 INFO - 'tests': ['damp', 'tps']}, 11:21:50 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:21:50 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 11:21:50 INFO - 'g4-stylo-e10s': {'talos_options': ['--stylo'], 11:21:50 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 11:21:50 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 11:21:50 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 11:21:50 INFO - 'g5-stylo-e10s': {'pagesets_name': 'tp5n.zip', 11:21:50 INFO - 'talos_options': ['--stylo'], 11:21:50 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 11:21:50 INFO - 'other-e10s': {'tests': ['a11yr', 11:21:50 INFO - 'ts_paint', 11:21:50 INFO - 'tpaint', 11:21:50 INFO - 'sessionrestore', 11:21:50 INFO - 'sessionrestore_many_windows', 11:21:50 INFO - 'sessionrestore_no_auto_restore', 11:21:50 INFO - 'tabpaint']}, 11:21:50 INFO - 'other-stylo-e10s': {'talos_options': ['--stylo'], 11:21:50 INFO - 'tests': ['a11yr', 11:21:50 INFO - 'ts_paint', 11:21:50 INFO - 'tpaint', 11:21:50 INFO - 'sessionrestore', 11:21:50 INFO - 'sessionrestore_many_windows', 11:21:50 INFO - 'sessionrestore_no_auto_restore', 11:21:50 INFO - 'tabpaint']}, 11:21:50 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 11:21:50 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 11:21:50 INFO - 'perf-reftest-singletons-stylo-e10s': {'talos_options': ['--stylo'], 11:21:50 INFO - 'tests': ['bloom_basic_singleton']}, 11:21:50 INFO - 'perf-reftest-stylo-e10s': {'talos_options': ['--stylo'], 11:21:50 INFO - 'tests': ['bloom_basic']}, 11:21:50 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:21:50 INFO - 'tsvgr_opacity', 11:21:50 INFO - 'tart', 11:21:50 INFO - 'tscrollx', 11:21:50 INFO - 'tsvg_static']}, 11:21:50 INFO - 'svgr-stylo-e10s': {'talos_options': ['--stylo'], 11:21:50 INFO - 'tests': ['tsvgx', 11:21:50 INFO - 'tsvgr_opacity', 11:21:50 INFO - 'tart', 11:21:50 INFO - 'tscrollx', 11:21:50 INFO - 'tsvg_static']}, 11:21:50 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 11:21:50 INFO - 'tp5o-stylo-e10s': {'pagesets_name': 'tp5n.zip', 11:21:50 INFO - 'talos_options': ['--stylo'], 11:21:50 INFO - 'tests': ['tp5o']}, 11:21:50 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:21:50 INFO - 'talos_options': ['--mitmproxy', 11:21:50 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:21:50 INFO - '--firstNonBlankPaint'], 11:21:50 INFO - 'tests': ['tp6_google', 11:21:50 INFO - 'tp6_youtube', 11:21:50 INFO - 'tp6_amazon', 11:21:50 INFO - 'tp6_facebook']}, 11:21:50 INFO - 'tp6-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:21:50 INFO - 'talos_options': ['--stylo', 11:21:50 INFO - '--mitmproxy', 11:21:50 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:21:50 INFO - '--firstNonBlankPaint'], 11:21:50 INFO - 'tests': ['tp6_google', 11:21:50 INFO - 'tp6_youtube', 11:21:50 INFO - 'tp6_amazon', 11:21:50 INFO - 'tp6_facebook']}, 11:21:50 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:21:50 INFO - 'talos_options': ['--stylo', 11:21:50 INFO - '--stylo-threads=1', 11:21:50 INFO - '--mitmproxy', 11:21:50 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:21:50 INFO - '--firstNonBlankPaint'], 11:21:50 INFO - 'tests': ['tp6_google', 11:21:50 INFO - 'tp6_youtube', 11:21:50 INFO - 'tp6_amazon', 11:21:50 INFO - 'tp6_facebook']}, 11:21:50 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 11:21:50 INFO - 'talos_options': ['--xperf_path', 11:21:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:21:50 INFO - 'tests': ['tp5n']}, 11:21:50 INFO - 'xperf-stylo-e10s': {'pagesets_name': 'tp5n.zip', 11:21:50 INFO - 'talos_options': ['--stylo', 11:21:50 INFO - '--xperf_path', 11:21:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:21:50 INFO - 'tests': ['tp5n']}}} 11:21:50 INFO - Running post-action listener: _resource_record_post_action 11:21:50 INFO - [mozharness: 2017-08-21 18:21:50.485541Z] Finished populate-webroot step (success) 11:21:50 INFO - [mozharness: 2017-08-21 18:21:50.485631Z] Running create-virtualenv step. 11:21:50 INFO - Running pre-action listener: _resource_record_pre_action 11:21:50 INFO - Running main action method: create_virtualenv 11:21:50 INFO - Creating virtualenv /builds/slave/test/build/venv 11:21:50 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:21:50 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:21:50 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 11:21:50 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:21:50 INFO - Using real prefix '/usr' 11:21:50 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:21:51 INFO - Installing distribute.............................................................................................................................................................................................done. 11:21:53 INFO - Installing pip.................done. 11:21:53 INFO - Return code: 0 11:21:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 11:21:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 11:21:53 INFO - Reading from file tmpfile_stdout 11:21:53 INFO - Output received: 11:21:53 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:21:53 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:21: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:21:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:21: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:21:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:21:53 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 0x28f31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2abea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c61f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c5f130>, '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 0x2c60030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c604c0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1503338607.495298-417619000', '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:21:53 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:21:53 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:21:53 INFO - Using env: {'DISPLAY': ':0', 11:21:53 INFO - 'HOME': '/home/cltbld', 11:21:53 INFO - 'LANG': 'en_US.UTF-8', 11:21:53 INFO - 'LANGUAGE': 'en_US:en', 11:21:53 INFO - 'LOGNAME': 'cltbld', 11:21:53 INFO - 'MAIL': '/var/mail/cltbld', 11:21:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:21:53 INFO - 'MOZ_NO_REMOTE': '1', 11:21:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:21:53 INFO - 'NO_EM_RESTART': '1', 11:21:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:21:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:21:53 INFO - 'PWD': '/builds/slave/test', 11:21:53 INFO - 'SHELL': '/bin/bash', 11:21:53 INFO - 'SHLVL': '1', 11:21:53 INFO - 'TERM': 'linux', 11:21:53 INFO - 'TMOUT': '86400', 11:21:53 INFO - 'USER': 'cltbld', 11:21:53 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1503338607.495298-417619000', 11:21:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:21:53 INFO - '_': '/tools/buildbot/bin/python'} 11:21:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:21:53 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:21:53 INFO - Cleaning up... 11:21:53 INFO - Return code: 0 11:21:53 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:21: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:21:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:21: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:21:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:21:53 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 0x28f31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2abea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c61f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c5f130>, '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 0x2c60030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c604c0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1503338607.495298-417619000', '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:21:53 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:21:53 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:21:53 INFO - Using env: {'DISPLAY': ':0', 11:21:53 INFO - 'HOME': '/home/cltbld', 11:21:53 INFO - 'LANG': 'en_US.UTF-8', 11:21:53 INFO - 'LANGUAGE': 'en_US:en', 11:21:53 INFO - 'LOGNAME': 'cltbld', 11:21:53 INFO - 'MAIL': '/var/mail/cltbld', 11:21:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:21:53 INFO - 'MOZ_NO_REMOTE': '1', 11:21:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:21:53 INFO - 'NO_EM_RESTART': '1', 11:21:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:21:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:21:53 INFO - 'PWD': '/builds/slave/test', 11:21:53 INFO - 'SHELL': '/bin/bash', 11:21:53 INFO - 'SHLVL': '1', 11:21:53 INFO - 'TERM': 'linux', 11:21:53 INFO - 'TMOUT': '86400', 11:21:53 INFO - 'USER': 'cltbld', 11:21:53 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1503338607.495298-417619000', 11:21:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:21:53 INFO - '_': '/tools/buildbot/bin/python'} 11:21:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:21:53 INFO - Downloading/unpacking psutil>=3.1.1 11:21:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:21:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:21:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:21:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:21:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:21:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:21:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:21:56 INFO - Installing collected packages: psutil 11:21:56 INFO - Running setup.py install for psutil 11:21:56 INFO - building 'psutil._psutil_linux' extension 11:21:56 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:21:57 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:21:57 INFO - building 'psutil._psutil_posix' extension 11:21:57 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:21:57 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:21:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:21:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:21:57 INFO - Successfully installed psutil 11:21:57 INFO - Cleaning up... 11:21:57 INFO - Return code: 0 11:21:57 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:21: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:21:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:21: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:21:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:21: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28f31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2abea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c61f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c5f130>, '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 0x2c60030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c604c0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1503338607.495298-417619000', '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:21: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 11:21: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 mozsystemmonitor==0.3 11:21:57 INFO - Using env: {'DISPLAY': ':0', 11:21:57 INFO - 'HOME': '/home/cltbld', 11:21:57 INFO - 'LANG': 'en_US.UTF-8', 11:21:57 INFO - 'LANGUAGE': 'en_US:en', 11:21:57 INFO - 'LOGNAME': 'cltbld', 11:21:57 INFO - 'MAIL': '/var/mail/cltbld', 11:21:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:21:57 INFO - 'MOZ_NO_REMOTE': '1', 11:21:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:21:57 INFO - 'NO_EM_RESTART': '1', 11:21:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:21:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:21:57 INFO - 'PWD': '/builds/slave/test', 11:21:57 INFO - 'SHELL': '/bin/bash', 11:21:57 INFO - 'SHLVL': '1', 11:21:57 INFO - 'TERM': 'linux', 11:21:57 INFO - 'TMOUT': '86400', 11:21:57 INFO - 'USER': 'cltbld', 11:21:57 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1503338607.495298-417619000', 11:21:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:21:57 INFO - '_': '/tools/buildbot/bin/python'} 11:21:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:21:58 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:21: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:21: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:21: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:21: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:21:59 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:21:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:21:59 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:21:59 INFO - Installing collected packages: mozsystemmonitor 11:21:59 INFO - Running setup.py install for mozsystemmonitor 11:21:59 INFO - Successfully installed mozsystemmonitor 11:21:59 INFO - Cleaning up... 11:21:59 INFO - Return code: 0 11:21:59 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:21: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:21:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:21: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:21:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:21: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', '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 0x28f31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2abea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c61f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c5f130>, '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 0x2c60030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c604c0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1503338607.495298-417619000', '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:21: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 11:21: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 jsonschema==2.5.1 11:21:59 INFO - Using env: {'DISPLAY': ':0', 11:21:59 INFO - 'HOME': '/home/cltbld', 11:21:59 INFO - 'LANG': 'en_US.UTF-8', 11:21:59 INFO - 'LANGUAGE': 'en_US:en', 11:21:59 INFO - 'LOGNAME': 'cltbld', 11:21:59 INFO - 'MAIL': '/var/mail/cltbld', 11:21:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:21:59 INFO - 'MOZ_NO_REMOTE': '1', 11:21:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:21:59 INFO - 'NO_EM_RESTART': '1', 11:21:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:21:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:21:59 INFO - 'PWD': '/builds/slave/test', 11:21:59 INFO - 'SHELL': '/bin/bash', 11:21:59 INFO - 'SHLVL': '1', 11:21:59 INFO - 'TERM': 'linux', 11:21:59 INFO - 'TMOUT': '86400', 11:21:59 INFO - 'USER': 'cltbld', 11:21:59 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1503338607.495298-417619000', 11:21:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:21:59 INFO - '_': '/tools/buildbot/bin/python'} 11:21:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:21:59 INFO - Downloading/unpacking jsonschema==2.5.1 11:21:59 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:21:59 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:21:59 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:21:59 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:22:00 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:22:00 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:22: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:22: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:22: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:22: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:22:00 INFO - Downloading functools32-3.2.3-2.tar.gz 11:22:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:22:00 INFO - warning: no files found matching '*.txt' 11:22:00 INFO - no previously-included directories found matching 'build' 11:22:00 INFO - no previously-included directories found matching 'dist' 11:22:00 INFO - no previously-included directories found matching '.git*' 11:22:00 INFO - Installing collected packages: jsonschema, functools32 11:22:00 INFO - Running setup.py install for functools32 11:22:01 INFO - warning: no files found matching '*.txt' 11:22:01 INFO - no previously-included directories found matching 'build' 11:22:01 INFO - no previously-included directories found matching 'dist' 11:22:01 INFO - no previously-included directories found matching '.git*' 11:22:01 INFO - Successfully installed jsonschema functools32 11:22:01 INFO - Cleaning up... 11:22:01 INFO - Return code: 0 11:22:01 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 11:22: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:22:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:22: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:22:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:22: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', '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 0x28f31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2abea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c61f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c5f130>, '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 0x2c60030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c604c0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1503338607.495298-417619000', '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:22: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 11:22: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 functools32==3.2.3-2 11:22:01 INFO - Using env: {'DISPLAY': ':0', 11:22:01 INFO - 'HOME': '/home/cltbld', 11:22:01 INFO - 'LANG': 'en_US.UTF-8', 11:22:01 INFO - 'LANGUAGE': 'en_US:en', 11:22:01 INFO - 'LOGNAME': 'cltbld', 11:22:01 INFO - 'MAIL': '/var/mail/cltbld', 11:22:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:22:01 INFO - 'MOZ_NO_REMOTE': '1', 11:22:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:22:01 INFO - 'NO_EM_RESTART': '1', 11:22:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:22:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:22:01 INFO - 'PWD': '/builds/slave/test', 11:22:01 INFO - 'SHELL': '/bin/bash', 11:22:01 INFO - 'SHLVL': '1', 11:22:01 INFO - 'TERM': 'linux', 11:22:01 INFO - 'TMOUT': '86400', 11:22:01 INFO - 'USER': 'cltbld', 11:22:01 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1503338607.495298-417619000', 11:22:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:22:01 INFO - '_': '/tools/buildbot/bin/python'} 11:22:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:22:01 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 11:22:01 INFO - Cleaning up... 11:22:01 INFO - Return code: 0 11:22:01 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:22: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:22:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:22: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:22:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:22: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', '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 0x28f31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2abea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c61f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c5f130>, '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 0x2c60030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c604c0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1503338607.495298-417619000', '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:22: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 11:22: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 blobuploader==1.2.4 11:22:01 INFO - Using env: {'DISPLAY': ':0', 11:22:01 INFO - 'HOME': '/home/cltbld', 11:22:01 INFO - 'LANG': 'en_US.UTF-8', 11:22:01 INFO - 'LANGUAGE': 'en_US:en', 11:22:01 INFO - 'LOGNAME': 'cltbld', 11:22:01 INFO - 'MAIL': '/var/mail/cltbld', 11:22:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:22:01 INFO - 'MOZ_NO_REMOTE': '1', 11:22:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:22:01 INFO - 'NO_EM_RESTART': '1', 11:22:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:22:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:22:01 INFO - 'PWD': '/builds/slave/test', 11:22:01 INFO - 'SHELL': '/bin/bash', 11:22:01 INFO - 'SHLVL': '1', 11:22:01 INFO - 'TERM': 'linux', 11:22:01 INFO - 'TMOUT': '86400', 11:22:01 INFO - 'USER': 'cltbld', 11:22:01 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1503338607.495298-417619000', 11:22:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:22:01 INFO - '_': '/tools/buildbot/bin/python'} 11:22:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:22:01 INFO - Downloading/unpacking blobuploader==1.2.4 11:22: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:22: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:22: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:22: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:22:02 INFO - Downloading blobuploader-1.2.4.tar.gz 11:22:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:22:02 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:22: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:22: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:22: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:22: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:22:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:22:03 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:22: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:22: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:22: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:22: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:22:03 INFO - Downloading docopt-0.6.1.tar.gz 11:22:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:22:03 INFO - Installing collected packages: blobuploader, requests, docopt 11:22:03 INFO - Running setup.py install for blobuploader 11:22:03 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:22:03 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:22:03 INFO - Running setup.py install for requests 11:22:03 INFO - Running setup.py install for docopt 11:22:03 INFO - Successfully installed blobuploader requests docopt 11:22:03 INFO - Cleaning up... 11:22:03 INFO - Return code: 0 11:22:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:22: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:22:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:22: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:22:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:22:03 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 0x28f31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2abea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c61f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c5f130>, '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 0x2c60030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c604c0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1503338607.495298-417619000', '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:22:03 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:22:03 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:22:03 INFO - Using env: {'DISPLAY': ':0', 11:22:03 INFO - 'HOME': '/home/cltbld', 11:22:03 INFO - 'LANG': 'en_US.UTF-8', 11:22:03 INFO - 'LANGUAGE': 'en_US:en', 11:22:03 INFO - 'LOGNAME': 'cltbld', 11:22:03 INFO - 'MAIL': '/var/mail/cltbld', 11:22:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:22:03 INFO - 'MOZ_NO_REMOTE': '1', 11:22:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:22:03 INFO - 'NO_EM_RESTART': '1', 11:22:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:22:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:22:03 INFO - 'PWD': '/builds/slave/test', 11:22:03 INFO - 'SHELL': '/bin/bash', 11:22:03 INFO - 'SHLVL': '1', 11:22:03 INFO - 'TERM': 'linux', 11:22:03 INFO - 'TMOUT': '86400', 11:22:03 INFO - 'USER': 'cltbld', 11:22:03 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1503338607.495298-417619000', 11:22:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:22:03 INFO - '_': '/tools/buildbot/bin/python'} 11:22:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:22:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:22:04 INFO - Running setup.py (path:/tmp/pip-bM5uyW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:22:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:22:04 INFO - Running setup.py (path:/tmp/pip-efC6Ao-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:22:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:22:04 INFO - Running setup.py (path:/tmp/pip-rffdpy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:22:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:22:04 INFO - Running setup.py (path:/tmp/pip-z3UziQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:22:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:22:04 INFO - Running setup.py (path:/tmp/pip-3Pp1Kn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:22:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:22:04 INFO - Running setup.py (path:/tmp/pip-9NvA7Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:22:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:22:04 INFO - Running setup.py (path:/tmp/pip-C88Ryi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:22:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:22:04 INFO - Running setup.py (path:/tmp/pip-3WsWA0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:22:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:22:04 INFO - Running setup.py (path:/tmp/pip-XoN7JL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:22:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:22:04 INFO - Running setup.py (path:/tmp/pip-LsD1vW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:22:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:22:04 INFO - Running setup.py (path:/tmp/pip-PS76vH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:22:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:22:04 INFO - Running setup.py (path:/tmp/pip-e98yiI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:22:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:22:04 INFO - Running setup.py (path:/tmp/pip-ijh8st-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:22:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:22:04 INFO - Running setup.py (path:/tmp/pip-u4sb4s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:22:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:22:05 INFO - Running setup.py (path:/tmp/pip-x5ethG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:22:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:22:05 INFO - Running setup.py (path:/tmp/pip-Xr9BKO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:22:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:22:05 INFO - Running setup.py (path:/tmp/pip-jotyJT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:22:05 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:22:05 INFO - Running setup.py install for manifestparser 11:22:05 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:22:05 INFO - Running setup.py install for mozcrash 11:22:05 INFO - Running setup.py install for mozdebug 11:22:05 INFO - Running setup.py install for mozdevice 11:22:05 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:22:05 INFO - Running setup.py install for mozfile 11:22:05 INFO - Running setup.py install for mozhttpd 11:22:05 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:22:05 INFO - Running setup.py install for mozinfo 11:22:05 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:22:05 INFO - Running setup.py install for mozInstall 11:22:06 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:22:06 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:22:06 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:22:06 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:22:06 INFO - Running setup.py install for mozleak 11:22:06 INFO - Running setup.py install for mozlog 11:22:06 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:22:06 INFO - Running setup.py install for moznetwork 11:22:06 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:22:06 INFO - Running setup.py install for mozprocess 11:22:06 INFO - Running setup.py install for mozprofile 11:22:06 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:22:06 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:22:06 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:22:06 INFO - Running setup.py install for mozrunner 11:22:06 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:22:06 INFO - Running setup.py install for mozscreenshot 11:22:06 INFO - Running setup.py install for moztest 11:22:06 INFO - Running setup.py install for mozversion 11:22:06 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:22:06 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:22:06 INFO - Cleaning up... 11:22:07 INFO - Return code: 0 11:22:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:22:07 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:22:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:22:07 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:22:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:22:07 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 0x28f31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2abea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c61f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c5f130>, '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 0x2c60030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c604c0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1503338607.495298-417619000', '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:22:07 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:22:07 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:22:07 INFO - Using env: {'DISPLAY': ':0', 11:22:07 INFO - 'HOME': '/home/cltbld', 11:22:07 INFO - 'LANG': 'en_US.UTF-8', 11:22:07 INFO - 'LANGUAGE': 'en_US:en', 11:22:07 INFO - 'LOGNAME': 'cltbld', 11:22:07 INFO - 'MAIL': '/var/mail/cltbld', 11:22:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:22:07 INFO - 'MOZ_NO_REMOTE': '1', 11:22:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:22:07 INFO - 'NO_EM_RESTART': '1', 11:22:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:22:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:22:07 INFO - 'PWD': '/builds/slave/test', 11:22:07 INFO - 'SHELL': '/bin/bash', 11:22:07 INFO - 'SHLVL': '1', 11:22:07 INFO - 'TERM': 'linux', 11:22:07 INFO - 'TMOUT': '86400', 11:22:07 INFO - 'USER': 'cltbld', 11:22:07 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1503338607.495298-417619000', 11:22:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:22:07 INFO - '_': '/tools/buildbot/bin/python'} 11:22:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:22:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:22:07 INFO - Running setup.py (path:/tmp/pip-ditoKg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:22:07 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:22:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:22:07 INFO - Running setup.py (path:/tmp/pip-463DWZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:22:07 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:22:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:22:07 INFO - Running setup.py (path:/tmp/pip-CM0NTR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:22:07 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:22:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:22:07 INFO - Running setup.py (path:/tmp/pip-2ViF7u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:22:07 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:22:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:22:07 INFO - Running setup.py (path:/tmp/pip-E2hTbK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:22:07 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:22:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:22:07 INFO - Running setup.py (path:/tmp/pip-e6TCen-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:22:07 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:22:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:22:07 INFO - Running setup.py (path:/tmp/pip-dfUItL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:22:07 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:22:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:22:07 INFO - Running setup.py (path:/tmp/pip-yAm36Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:22:07 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:22:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:22:07 INFO - Running setup.py (path:/tmp/pip-NhrBlH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:22:07 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:22:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:22:07 INFO - Running setup.py (path:/tmp/pip-IkoUKu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:22:07 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:22:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:22:07 INFO - Running setup.py (path:/tmp/pip-9U6YtC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:22:08 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:22:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:22:08 INFO - Running setup.py (path:/tmp/pip-YhA0fS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:22:08 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:22:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:22:08 INFO - Running setup.py (path:/tmp/pip-laPV2T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:22:08 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:22:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:22:08 INFO - Running setup.py (path:/tmp/pip-XRfFA6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:22:08 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:22:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:22:08 INFO - Running setup.py (path:/tmp/pip-EL0GVO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:22:08 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:22:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:22:08 INFO - Running setup.py (path:/tmp/pip-Fc9CV0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:22:08 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:22:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:22:08 INFO - Running setup.py (path:/tmp/pip-ZSbABe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:22:08 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:22:08 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:22:08 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:22:08 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:22:08 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:22:08 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:22:08 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:22:08 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:22:08 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:22:08 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:22:08 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:22:08 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:22:09 INFO - Downloading blessings-1.6.tar.gz 11:22:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:22:09 INFO - Installing collected packages: blessings 11:22:09 INFO - Running setup.py install for blessings 11:22:09 INFO - Successfully installed blessings 11:22:09 INFO - Cleaning up... 11:22:09 INFO - Return code: 0 11:22:09 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:22:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:22:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:22:10 INFO - Reading from file tmpfile_stdout 11:22:10 INFO - Current package versions: 11:22:10 INFO - argparse == 1.2.1 11:22:10 INFO - blessings == 1.6 11:22:10 INFO - blobuploader == 1.2.4 11:22:10 INFO - docopt == 0.6.1 11:22:10 INFO - functools32 == 3.2.3-2 11:22:10 INFO - jsonschema == 2.5.1 11:22:10 INFO - manifestparser == 1.1 11:22:10 INFO - mozInstall == 1.13 11:22:10 INFO - mozcrash == 1.0 11:22:10 INFO - mozdebug == 0.1 11:22:10 INFO - mozdevice == 0.51 11:22:10 INFO - mozfile == 1.2 11:22:10 INFO - mozhttpd == 0.7 11:22:10 INFO - mozinfo == 0.10 11:22:10 INFO - mozleak == 0.1 11:22:10 INFO - mozlog == 3.5 11:22:10 INFO - moznetwork == 0.27 11:22:10 INFO - mozprocess == 0.25 11:22:10 INFO - mozprofile == 0.28 11:22:10 INFO - mozrunner == 6.13 11:22:10 INFO - mozscreenshot == 0.1 11:22:10 INFO - mozsystemmonitor == 0.3 11:22:10 INFO - moztest == 0.8 11:22:10 INFO - mozversion == 1.4 11:22:10 INFO - psutil == 3.1.1 11:22:10 INFO - requests == 1.2.3 11:22:10 INFO - wsgiref == 0.1.2 11:22:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:22:10 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:22:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:22:10 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:22:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:22:10 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 0x28f31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2abea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c61f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c5f130>, '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 0x2c60030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c604c0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1503338607.495298-417619000', '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:22:10 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:22:10 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:22:10 INFO - Using env: {'DISPLAY': ':0', 11:22:10 INFO - 'HOME': '/home/cltbld', 11:22:10 INFO - 'LANG': 'en_US.UTF-8', 11:22:10 INFO - 'LANGUAGE': 'en_US:en', 11:22:10 INFO - 'LOGNAME': 'cltbld', 11:22:10 INFO - 'MAIL': '/var/mail/cltbld', 11:22:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:22:10 INFO - 'MOZ_NO_REMOTE': '1', 11:22:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:22:10 INFO - 'NO_EM_RESTART': '1', 11:22:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:22:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:22:10 INFO - 'PWD': '/builds/slave/test', 11:22:10 INFO - 'SHELL': '/bin/bash', 11:22:10 INFO - 'SHLVL': '1', 11:22:10 INFO - 'TERM': 'linux', 11:22:10 INFO - 'TMOUT': '86400', 11:22:10 INFO - 'USER': 'cltbld', 11:22:10 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1503338607.495298-417619000', 11:22:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:22:10 INFO - '_': '/tools/buildbot/bin/python'} 11:22:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:22:10 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:22:10 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:22:10 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:22:10 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:22:10 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:22:10 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:22:10 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:22:10 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:22:10 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:22:10 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 11:22: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:22: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:22: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:22: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:22:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 11:22:11 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:22:11 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:22:11 INFO - Installing collected packages: simplejson 11:22:11 INFO - Running setup.py install for simplejson 11:22:11 INFO - building 'simplejson._speedups' extension 11:22:11 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:22:12 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:22:12 INFO - Successfully installed simplejson 11:22:12 INFO - Cleaning up... 11:22:12 INFO - Return code: 0 11:22:12 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:22: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:22:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:22: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:22:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:22:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28f31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2abea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c61f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c5f130>, '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 0x2c60030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c604c0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1503338607.495298-417619000', '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:22:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 11:22:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 11:22:12 INFO - Using env: {'DISPLAY': ':0', 11:22:12 INFO - 'HOME': '/home/cltbld', 11:22:12 INFO - 'LANG': 'en_US.UTF-8', 11:22:12 INFO - 'LANGUAGE': 'en_US:en', 11:22:12 INFO - 'LOGNAME': 'cltbld', 11:22:12 INFO - 'MAIL': '/var/mail/cltbld', 11:22:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:22:12 INFO - 'MOZ_NO_REMOTE': '1', 11:22:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:22:12 INFO - 'NO_EM_RESTART': '1', 11:22:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:22:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:22:12 INFO - 'PWD': '/builds/slave/test', 11:22:12 INFO - 'SHELL': '/bin/bash', 11:22:12 INFO - 'SHLVL': '1', 11:22:12 INFO - 'TERM': 'linux', 11:22:12 INFO - 'TMOUT': '86400', 11:22:12 INFO - 'USER': 'cltbld', 11:22:12 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1503338607.495298-417619000', 11:22:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:22:12 INFO - '_': '/tools/buildbot/bin/python'} 11:22:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:22:12 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:22:12 INFO - Cleaning up... 11:22:12 INFO - Return code: 0 11:22:12 INFO - Running post-action listener: _resource_record_post_action 11:22:12 INFO - Running post-action listener: _start_resource_monitoring 11:22:12 INFO - Starting resource monitoring. 11:22:12 INFO - [mozharness: 2017-08-21 18:22:12.816408Z] Finished create-virtualenv step (success) 11:22:12 INFO - [mozharness: 2017-08-21 18:22:12.817438Z] Running install step. 11:22:12 INFO - Running pre-action listener: _resource_record_pre_action 11:22:12 INFO - Running main action method: install 11:22:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:22:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:22:13 INFO - Reading from file tmpfile_stdout 11:22:13 INFO - Detecting whether we're running mozinstall >=1.0... 11:22:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:22:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:22:13 INFO - Reading from file tmpfile_stdout 11:22:13 INFO - Output received: 11:22:13 INFO - Usage: mozinstall [options] installer 11:22:13 INFO - Options: 11:22:13 INFO - -h, --help show this help message and exit 11:22:13 INFO - -d DEST, --destination=DEST 11:22:13 INFO - Directory to install application into. [default: 11:22:13 INFO - "/builds/slave/test"] 11:22:13 INFO - --app=APP Application being installed. [default: firefox] 11:22:13 INFO - mkdir: /builds/slave/test/build/application 11:22:13 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:22:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 11:22:31 INFO - Reading from file tmpfile_stdout 11:22:31 INFO - Output received: 11:22:31 INFO - /builds/slave/test/build/application/firefox/firefox 11:22:31 INFO - Running post-action listener: _resource_record_post_action 11:22:31 INFO - [mozharness: 2017-08-21 18:22:31.030133Z] Finished install step (success) 11:22:31 INFO - [mozharness: 2017-08-21 18:22:31.030410Z] Running setup-mitmproxy step. 11:22:31 INFO - Running pre-action listener: _resource_record_pre_action 11:22:31 INFO - Running main action method: setup_mitmproxy 11:22:31 INFO - Skipping: mitmproxy is not required 11:22:31 INFO - Running post-action listener: _resource_record_post_action 11:22:31 INFO - [mozharness: 2017-08-21 18:22:31.031544Z] Finished setup-mitmproxy step (success) 11:22:31 INFO - [mozharness: 2017-08-21 18:22:31.031762Z] Running run-tests step. 11:22:31 INFO - Running pre-action listener: _resource_record_pre_action 11:22:31 INFO - Running pre-action listener: _set_gcov_prefix 11:22:31 INFO - Running main action method: run_tests 11:22:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:22:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:22:31 INFO - Python 2.7.3 11:22:31 INFO - Return code: 0 11:22:31 INFO - grabbing minidump binary from tooltool 11:22:31 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:22:31 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 0x2c5f130>, '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 0x2c60030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c604c0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:22:31 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:22:31 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:22:31 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:22:31 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:22:31 INFO - Return code: 0 11:22:31 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:22:31 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:22:31 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:22:31 INFO - ENV: RUST_BACKTRACE is now full 11:22:31 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:22:31 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:22:31 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/dgb5MIIuQw2LKtY8dH2Fjg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-006', '--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:22:31 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/dgb5MIIuQw2LKtY8dH2Fjg/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-006 --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:22:31 INFO - Using env: {'DISPLAY': ':0', 11:22:31 INFO - 'HOME': '/home/cltbld', 11:22:31 INFO - 'LANG': 'en_US.UTF-8', 11:22:31 INFO - 'LANGUAGE': 'en_US:en', 11:22:31 INFO - 'LOGNAME': 'cltbld', 11:22:31 INFO - 'MAIL': '/var/mail/cltbld', 11:22:31 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:22:31 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:22:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:22:31 INFO - 'MOZ_NO_REMOTE': '1', 11:22:31 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:22:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:22:31 INFO - 'NO_EM_RESTART': '1', 11:22:31 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:22:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:22:31 INFO - 'PWD': '/builds/slave/test', 11:22:31 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:22:31 INFO - 'RUST_BACKTRACE': 'full', 11:22:31 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 11:22:31 INFO - 'SHELL': '/bin/bash', 11:22:31 INFO - 'SHLVL': '1', 11:22:31 INFO - 'TERM': 'linux', 11:22:31 INFO - 'TMOUT': '86400', 11:22:31 INFO - 'USER': 'cltbld', 11:22:31 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1503338607.495298-417619000', 11:22:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:22:31 INFO - '_': '/tools/buildbot/bin/python'} 11:22:31 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/dgb5MIIuQw2LKtY8dH2Fjg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-006', '--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:22:31 INFO - mozversion application_buildid: 20170821171611 11:22:31 INFO - mozversion application_changeset: a9d372645a32b8d23d44244f351639af9d73b96a 11:22:31 INFO - mozversion application_display_name: Nightly 11:22:31 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:22:31 INFO - mozversion application_name: Firefox 11:22:31 INFO - mozversion application_remotingname: firefox 11:22:31 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 11:22:31 INFO - mozversion application_vendor: Mozilla 11:22:31 INFO - mozversion application_version: 57.0a1 11:22:31 INFO - mozversion platform_buildid: 20170821171611 11:22:31 INFO - mozversion platform_changeset: a9d372645a32b8d23d44244f351639af9d73b96a 11:22:31 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 11:22:31 INFO - mozversion platform_version: 57.0a1 11:22:31 INFO - using testdate: 1503339751 11:22:31 INFO - actual date: 1503339751 11:22:31 INFO - starting webserver on 'localhost:39755' 11:22:31 INFO - SUITE-START | Running 2 tests 11:22:31 INFO - TEST-START | dromaeo_css 11:22:31 INFO - Initialising browser for dromaeo_css test... 11:22:31 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:39755/getInfo.html -profile /tmp/tmp3NoFXs/profile 11:22:31 INFO - TEST-INFO | started process 3761 (/builds/slave/test/build/application/firefox/firefox http://localhost:39755/getInfo.html) 11:22:40 INFO - TEST-INFO | 3761: exit 0 11:22:40 INFO - Browser initialized. 11:22:40 INFO - Running cycle 1/1 for dromaeo_css test... 11:22:40 INFO - TEST-INFO | started process 3980 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3NoFXs/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 11:22:41 INFO - PID 3980 | 11:22:41 INFO - PID 3980 | (/builds/slave/test/build/application/firefox/firefox:4030): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 11:22:41 INFO - PID 3980 | 11:22:42 INFO - PID 3980 | 11:22:42 INFO - PID 3980 | (/builds/slave/test/build/application/firefox/firefox:4088): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 11:22:42 INFO - PID 3980 | 11:22:42 INFO - PID 3980 | __metrics Screen width/height:1600/1200 11:22:42 INFO - PID 3980 | colorDepth:24 11:22:42 INFO - PID 3980 | Browser inner width/height: 1024/768 11:22:42 INFO - PID 3980 | __metrics 11:22:51 INFO - PID 3980 | RSS: Main: 165126144 11:22:51 INFO - PID 3980 | 11:25:49 INFO - PID 3980 | Cycle 1(1): loaded http://localhost:39755/tests/dromaeo/cssquery-dojo.html (next: http://localhost:39755/tests/dromaeo/cssquery-ext.html) 11:25:50 INFO - PID 3980 | RSS: Main: 169828352 11:25:50 INFO - PID 3980 | 11:28:52 INFO - PID 3980 | Cycle 1(1): loaded http://localhost:39755/tests/dromaeo/cssquery-ext.html (next: http://localhost:39755/tests/dromaeo/cssquery-jquery.html) 11:28:53 INFO - PID 3980 | RSS: Main: 166768640 11:28:53 INFO - PID 3980 | 11:31:54 INFO - PID 3980 | Cycle 1(1): loaded http://localhost:39755/tests/dromaeo/cssquery-jquery.html (next: http://localhost:39755/tests/dromaeo/cssquery-mootools.html) 11:31:55 INFO - PID 3980 | RSS: Main: 167415808 11:31:55 INFO - PID 3980 | 11:34:56 INFO - PID 3980 | Cycle 1(1): loaded http://localhost:39755/tests/dromaeo/cssquery-mootools.html (next: http://localhost:39755/tests/dromaeo/cssquery-prototype.html) 11:34:57 INFO - PID 3980 | RSS: Main: 166756352 11:34:57 INFO - PID 3980 | 11:38:01 INFO - PID 3980 | Cycle 1(1): loaded http://localhost:39755/tests/dromaeo/cssquery-prototype.html (next: http://localhost:39755/tests/dromaeo/cssquery-yui.html) 11:38:01 INFO - PID 3980 | RSS: Main: 168329216 11:38:01 INFO - PID 3980 | 11:41:03 INFO - PID 3980 | Cycle 1(1): loaded http://localhost:39755/tests/dromaeo/cssquery-yui.html (next: http://localhost:39755/tests/dromaeo/cssquery-dojo.html) 11:41:03 INFO - PID 3980 | RSS: Main: 170885120 11:41:03 INFO - PID 3980 | 11:41:03 INFO - PID 3980 | __start_tp_report 11:41:03 INFO - PID 3980 | _x_x_mozilla_page_load 11:41:03 INFO - PID 3980 | _x_x_mozilla_page_load_details 11:41:03 INFO - PID 3980 | |i|pagename|runs| 11:41:03 INFO - PID 3980 | |0;dojo.html;3502.9824850875743;3520.823958802059;3536.7524273300864;3559.8220088995554;3573.3746594345985;6195.938040619592;6268.216472940882;6316.5262605304615;6335.9683201583985;6341.080543321215;6164.383561643834;6242.812715618527;6266.091416744569;6360.618362898218;6371;5470.890582188354;5472.5621950243985;5499.697516636584;5532.253145825302;5567.053600887839;5396.568274538027;5559.8888022239535;5599.496045355917;5608.915866261989;5645.8588535286535;5493.395726470085;5509.173623956399;5543.279373681436;5552.611317207777;5575.972120139414;5463.480969307949;5498.972505137489;5514.531264842493;5566.916496252559;5570.888582228374;5436.483534064258;5509.173623956399;5541.861453463655;5550.139728342114;5552.888942221173;6208.627482351028;6208.627482351028;6277.246730392382;6311.905321420182;6312.305646378894;6704.229013663394;6747.359000894907;6775.457963362919;6801.829954251183;6909.481788865855;6784.457243420515;6785.423239024689;6849.1438570178725;6935.826604334881;6956.443484521226;6310.211223597004;6357.364263573651;6388.105665206875;6413.358664133596;6417.197850268716;6984.930150698428;7002.124734408199;7022.438204943593;7076.044733960953;7122.964385178041;6595.670216489157;6679.86640267192;6711.161104861892;6754.3921047106;6759.256481787098;6835.4189893859575;6835.521513494008;6899.344562266577;6907.516473846883;6929.688164032631;6749.493787965922;6750.594964302158;6793.830154246085;6821.658917054127;6839.0425340452375;6612.371824676648;6679.998000299896;6682.0311054896765;6684.699188536528;6860.965695171492;4869.975650121727;4875.19559272716;4889.168841296988;4929.211326187793;4931.827386041471;4375.9935214900115;4391.538888416734;4402.141582391467;4477.3731677565165;4500.099980003947;6423.710933008026;6424.935750642434;6443.936750436219;6456.289808121103;6531.967340163269;6682.766103186365;6797.388235058868;6832.180138383425;6896.103506544117;6909.1018167638895;6363.0455431684695;6380.393862583047;6381.936180638227;6386.265579458329;6388.105665206875;5406.486383793534;5434.91847622286;5459.2902922619805;5461.0716178249795;5514.420985796514;7130.465215108888;7188.964055179691;7211.459140564479;7215.458840586872;7243.420526357879;6809.080774095632;6833.760818371532;6902.965485172643;6913.274106218976;6919.827004324932;6891.793246202622;6975.546589471668;7091.361777439849;7104.183018952886;7183.604901730455;6680.565763225375;6755.864882702417;6759.493038022069;6760.459163267025;6773.491988100814;6786.660666966533;6856.760013399507;6873.20958089826;6875.518713689994;6875.5874647521305;6540.803775886731;6553.934460655332;6561.081448597296;6632.038354438483;6663.600183988976;6484.319146489551;6578.7368505261165;6580.605163690194;6593.3736295051895;6616.66916654175;6565.048068030204;6565.310642382672;6571.211454625284;6586.176727909012;6600.07598936159;6662.500312476681;6734.898976515258;6753.425958793558;6762.391384775394;6775.186977562526;6460.676966151767;6470.644114573555;6535.477161827138;6538.444232240313;6541.934580654323 11:41:03 INFO - PID 3980 | |1;ext.html;859.3115959325917;928.1924725488824;960.3277705606077;1317.0648839324078;1338.2238301784967;40966.385504217425;41885.162296754046;41939.370909436344;41976.37035444463;41994.37008444868;39656;39976.400353994715;40001;40058.799706001504;40090.7995460023;6887.896681549768;6967.338102880219;6967.721291148348;6971.7211311547735;6975.755848545302;7082.291770822928;7167.820804479904;7168.175659799112;7172.820679483002;7181.928180718178;7173.605451700155;7222.133343998701;7532.585707786069;7712.730054448096;7713.228677132298;7615.504992175519;7671.462997590171;7677.347425468842;7681.23187681233;7681.731139410122;7315.30504602062;7497.2877576630135;7580.620968951531;7668.923310766932;7675.078990521118;39366.60633393658;39648.405273920915;39754.403683944765;39851;39872.202555948716;3483.756137070406;3517.9120521986897;3542.787432754017;3545.85816567337;3551.751377403583;30982.225444363845;31114.53328200079;31254.843725781226;31301;31325.530117048263;5119.769610367543;5120.15517439622;5136.126858434075;5140.485951404867;5157.871053223662;260959;261030;262494;263123;263200;49619;49825.25262121071;49884.009279257574;50046;50759.746201268754;53575.19637205445;53627.73186134122;53961.190582140516;53970;54128.72935635297;16196.271167797242;16196.919015404848;16205.594860128354;16206.270717817726;16258.593535161479;12995.610131696065;13007.674808129683;13008.21950682962;13021.414036368385;13034.934825325812;13193.670158245928;14630.707385852224;14733.484328048682;14774.26128693561;14854.405823766929;5214.322138122096;5813.389594092644;5910.083936989773;5911.615744976562;5972.343042265347;1098.8626421697288;1111.5998240633367;1117.1565468071553;1118.8657361116718;1129.3224065560762;24833.62749558758;24836.503269934863;24911;24942.875285623457;25094;1210.8375959079383;1211.2732360583755;1216.0697066743949;1229.1764517773113;1234.062112794265;17050;17245;17453.38913138034;17453.563660908578;17557.20992555338;281398;282610;282853;283529;284149;58300.70849645725;58645;58949;58950.705246473495;58974;1503.864652181287;1543.6063803729976;1557.8753699703996;1561.0555613853683;1566.5848550134224;28709.425811483237;28960.42079158447;29291.56062659019;29569.704302956696;30106.096817095524;39980.80009599934;40112;40193.39709904295;40211.39682904817;40269.19461610693;242282;243532;243870;247140;248465;38030.80984595059;38253.80873095617;38313.425298619986;38374.23251534898;38374.80812595919;47078.76460617675;47080.05839883115;47125.764371177924;47503.287450687574;47825;35915.46126808048;35962.820185898905;36201.27597447984;36326.455103174005;36631;35788.28423431569;35915.28169436545;35925.820370899026;36038.27923441569;36378.636213637525;39559.40660890147;40836.38745418881;40855.79572102239;40915.18169636531;41183.176336473705;34139.82930085334;34253.31493370169;34308.65691343055;34594.48108278428;35414.468782967764;25408.491830162922;26692.332691682863;27285.59071613967;27452.588211176448;27461.17616471509 11:41:03 INFO - PID 3980 | |2;jquery.html;568.5161727890206;569.5842035314221;584.0917373484233;584.2463222443049;584.3980699879125;22814.20150294738;23566.410839729015;23571.646425303636;23597.64603530944;23601.5279694406;25388;28041.018564350252;28102;28102.43795124096;28208.294792630142;6022.126791615224;6144.385561443843;6154.969225153868;6155.138280640714;6155.7229924653275;6046.486048685867;6207.193064901557;6267.05994100884;6341.2707538633185;6355.968220158893;6311.77908773193;6315.652639104847;6316.052592111198;6317.178766760315;6321.77873774418;6299.905501417483;6301.684915754194;6304.369563043705;6305.621662700252;6318.241810982689;5853.326867410217;5856.121581762727;5861.589688721791;5864.648121112704;5865.794697185578;30048.849755751082;31063.136211827135;31736;31754.364912701847;31936;2165.4261620670536;2193.9451513712124;2194.2429861697688;2194.6378847490146;2195.6816261642134;20266.49333766653;20837.895810521;20849.791502084936;20854.37436876881;20876.06057727406;2444.5477586646525;2480.1195575570773;2516.30801529579;2545.376382786211;2548.7578680025554;147660;150402;150673;150725;150763;15194.392224310905;15585.454509092127;15620.921895390451;15689.529314120595;16535.173241337885;24327;24332.635010474856;24367.634485482733;24375.75624243735;24391.878040609685;10738;10744;10929.890701093047;10939.015488605904;10952.233343666026;10130.138938190188;10210.795784084277;10273.178145748323;10275.588976441008;10351.378917264989;8471.872921906177;9941.353812002197;9955.402675839472;10077;10084.193264538819;2765.778737700979;2771.9861400692866;2772.1683494951435;2801.607774911514;2849.259192609895;1043.3062013760764;1068.8396740488834;1074.5809134437575;1075.5482697267166;1079.2660990526517;22212.222572209896;22272.331830045125;22625.547489050456;23011.309660710205;23110.075596975934;1093.5461783359976;1151.424287856072;1159.652104368686;1163.3717792392013;1164.231607139284;11964;12525.185862918881;12551.560695375618;12632.873671263353;12674.936625316814;620827;627915;632743;646487;647248;135801;136316;138439.30780346034;141639;142588.28705856611;1350.6758377989408;1370.3833275026277;1381.5233744358181;1392.1020941492884;1392.1577445645441;19605;19655.508612284808;19925.701114483003;20168.49578760543;20324.695129572774;61297.38702613095;62169.37830621636;63300.68349658222;64471.35528644654;64993.67503162643;82672;82823.5858820702;83294.16705832865;83512.58243708743;84209.5789521073;13219.66950826237;13648.317584120952;14947.701045978802;15272.923635381752;15462.613434664223;24681.382965426008;24904.12835550747;24932.37669058288;25030.3742406434;25136.12023579166;19939.20243190314;20235.19059237673;20288.289909853083;20382.184712611328;20393.898030509754;15687.68624627524;15806.7628985563;16031;16518.917405413376;16566.17169141562;18779.15493802755;19175.616487670446;19798.20807167697;19999.10004049792;20041.599168016266;15282.388704452142;15489.767653484982;15566;15579.688406231586;15588.84411155874;18806.341778037702;18952.71570926465;20749;20915;20952.58094838125 11:41:03 INFO - PID 3980 | |3;mootools.html;1408.2677007955863;1444.3500424808838;1455.3305479479432;1455.832579253385;1466.4354223623905;15815.288312025958;16375.672486550262;16384.016958982455;16406.507804765846;16653.583660408494;16748.58128546787;17024.404145854896;17033.063181525013;17038.403655872047;17051.232694528746;2523.205190365029;2587.6636037315125;2649.1125472966482;2649.297936046949;2650.2446802661248;2597.649317342163;2608.2566468556465;2619.9214023579325;2626.4747050589863;2630.789536837048;2535.911243106492;2575.111586502663;2620.1484517531785;2620.8689565521745;2623.108143231301;2485.7389974052735;2496.4383013821925;2539.669842920418;2582.289870285668;2584.6769153855766;2512.208654273898;2523.1799665108915;2526.9620955685496;2530.5065512224937;2530.911418100376;15841.366345346172;16074.919625401915;16087.758683619755;16112.75830862538;16153.757693634605;7698.076230852277;7908.090569584514;7918;7919.485233459806;7921.722739704141;4775.068861571995;4806.975965120152;4914.606831453475;4941.308216849644;4962.1812400953795;1900.9904950475159;1908.3034692337335;1924.6535623587888;1963.980360196394;1971.822535971755;28283.434331313463;28419;28519;28551;28923.132306030642;6373.298937116913;6656.2345330287635;6715.630640314829;6820.556663816836;6868.244493105754;19173.32893348726;19199.52001199981;19203.423897283104;19208.231670733014;19255.51861203453;8044.517328960281;8170.305524030524;8175.7138500152205;8188.5496297703;8194.959025204837;7323.121225452873;7438.516496427715;7456;7507.737229197061;7531.887021694679;5264.131418316011;5399.919001214985;5413.485718856702;5438.755256013489;5452.509274165344;1508.3966413434493;1508.7133444645483;1513.3341329814846;1515.9545213643607;1531.1425601663104;970.4080510888352;975.2441857560448;989.094978095035;1009.2430676992255;1010.2978429991085;8444.929899899667;8493.447925884797;8503.319734421231;8507;8581.78545536354;718.6406796601699;749.2058418076856;1034.1881622925966;1044.9373037617768;1075.876274228458;5756.429576551162;5767.942320576824;5818.44724751148;5915;5955.13650520672;23343.18298859532;23382.883085584803;24081.277561673178;24182.274531764077;24442.14452494154;23446.296611101694;23718.407039823796;23887.880560597085;23915.641265381033;23921.401964951016;11740.708522062567;12067.275963442222;12076.818847717292;12081.154319197747;12202.267863928193;8402.41183117176;8967.910320896968;9056.592453339485;9085.454872707658;9258;20667.793322066587;20777.58444831065;20858.47853803667;21116.04977775973;21372.89313553422;21129.36611901584;21419.46451338729;21566.245181418573;21689.457763556038;21876.124955001622;13272.203667779964;13333.866581346938;13389;13472.5284615038;13472.79790803119;14944.103353798806;14976.326065327305;14996.325165367803;15000.324985375466;15073.397064117313;12216.816747748613;12413.006959443042;12509.311987840756;12622.179558328678;12679.175853569488;11962.760744784882;12302.692432689255;12367.443465044274;12393.132480726263;12573.874261257637;10596.8940310599;10823.350598964087;10827.07969822574;10832;10852.403117828595;8408.915910841059;8417.410781245499;8503.362247831561;8559.22966932979;8568.100349463466;8537.53043582609;8661.263792577702;8667.956660216658;8671.393002489765;8674.739757807276 11:41:03 INFO - PID 3980 | |4;prototype.html;508.48388885281446;510.82121257559857;532.7362955337109;537.9731013449327;540.4433433563429;6225.906611400827;6242.438180563749;6260.248770147588;6268.843278918023;6284.780032698856;5975.073863551145;6110.816675499731;6115.296740874801;6116.755329786814;6139.662318572477;4750.501197374278;4810.374651295327;4826.107170173529;4849.903001939959;4872.926906096393;4649.744264065475;4778.1126455050235;4791.808327666889;4812.6552046327815;4830.661853670244;4775.474697783241;4786.784594693229;4796.400449943757;4805.303231031498;4808.951910480885;4794.9280760788615;4799.328094066834;4808.254720518308;4815.49437309081;4849.539293767087;4330.891727706801;4336.349547567858;4339.869803905856;4340.567612687837;4348.456442944632;6052.515798736091;6067.848303792396;6079.300880398767;6106.206193194901;6110.175126357974;5768.596198266123;5796.768244225961;5802;5831.504322132624;5836.2996440427;6601.405873471411;6623.437007854338;6630.370114839083;6658.500612454037;6661.467082633426;4939.3578834751615;4940.3330550375595;4943.332650092263;4947.381577302837;4955.876103097416;6933.341332573397;6965.756198533027;7006.894896576556;7069.611171385572;7095.7161713531395;5056.165732654071;5063.11395505785;5065.594752419871;5066.873328166752;5072.644914855925;5149.48505149482;5159.561437277874;5167.741612919414;5168.664036837594;5183.118869792144;5754.676424422322;5789.015867302569;5809.50619197373;5811.215485909433;5834.649921004753;6604.86790264192;6622.304658010936;6629.303923088007;6644.202695676453;6679.2318883329035;1687.147990264933;1727.2400143936627;1743.8256174382461;1769.575301927528;1779.4572655340246;1233.5559198688466;1256.0705078242217;1258.2576279994846;1271.5295340723992;1275.776739070659;6292.716827742671;6306.747730090837;6310.43206111443;6313.05304204373;6338.8415289617205;6604.504662150358;6680.966595166993;6733.797986060426;6735.4274886635185;6777.661116944231;6263.96868015657;6289.591176573508;6300.621962682254;6319.557630965788;6346.27017892939;3525.453554699026;3539.43369060949;3571.714262858965;3571.767835090711;3606.6573675500786;6942.51402401827;6961;7050.365467107985;7072.929270707227;7155.427565794828;6845.110135682329;6876.587404755731;6911.40391639554;6931.965340173368;7017.824554386079;7052.153741550842;7056.894146587805;7071.964640176869;7142.964285178645;7151.284871512911;6712.194536655633;6720.764773232913;6772.86454270902;6807.897881531682;6830.633873225275;6593.835154121185;6702.798916032527;6706.731730730911;6723.2940541244425;6794.388505034571;7019.3682568569075;7021.754238601625;7090.4682148840075;7105;7148.964255178691;5093.567046801063;5109.131447653982;5110.488951105009;5120.564751996122;5124.923126153185;6796.35434633709;6803.93196068033;6820.965895170492;6821.1814582250445;6837.965810170917;6477.902831457626;6512.706928188148;6564.142534524513;6585.670716464253;6587.63767992765;6401.967990160019;6496.967515162394;6553.246376666553;6566;6630.30381809903;6371.840703982438;6427.453666438405;6485.967570162119;6494.74021039172;6557.180352455943;6537.542372033912;6560.8359791005605;6607.867842643024;6635.402813746786;6642.9217266200885;6279.277883043508;6344.206974128234;6393.4885209184085;6403.167588213502;6410.1987251593555 11:41:03 INFO - PID 3980 | |5;yui.html;936.1761649748223;943.6508491858009;945.4941606240658;951.5908159491416;963.4412041016213;16897.408590699328;16905.492835214933;16912.91543542282;16930.576735581602;21863;22388.55222895545;22517.09931602734;22680.773192268072;22729;22804.54390912185;1011.2870426349443;1030.1449796668746;1030.8814486334093;1031.988651121901;1033.5452400943598;1048.1300520567947;1077.219016213247;1085.967420977368;1089.624079692505;1092.3773449133996;1138.4478527913955;1138.8064029115071;1139.191174266272;1139.191174266272;1140.0366690146814;1141.4463984967285;1143.6912033750882;1144.0332918683782;1145.123980155182;1145.5646854195395;827.1315119124955;827.4662842466576;828.4366630691128;830.5722552885269;835.7033253195088;20234.595308093754;20430.591388172154;20527.692084618742;20677;20865.37403877886;21693.56612867734;21896;22338.776612233833;22532.324030279116;22767.31698049061;17647.294108235656;17803.73294400585;17896.105194740212;17963.371282005068;18267.634647307113;3759.9624003759886;3764.4729737836724;3778.848846046155;3791;3811.942820857689;149049.25475372662;150052;150276;150394;150447;17182.484525464257;17239.56901077458;17655.646887062445;17666.734998975026;18071.367502137364;32941.3411731764;33228.169295767315;33347.16632084169;33449.49825752616;33613.83193084019;8392.874106888401;8731.257843083282;8907.643694252287;9293.767655808659;9582.329236953487;4685.906281874411;4695.037517308943;4780.784864681098;4782.115308667838;4794.496577859344;5697.4587414195585;5734.39788822176;5796.565257605696;5799.507041901401;5815.94184058154;1085.8316960871077;1096.9725756856142;1116.6370929447799;1119.92720473169;1124.7806677697934;719.2052781676173;725.5574099799119;735.3786050787077;753.2279413601103;753.9509931854412;13161.407736651681;13162.407691653898;13364.799528007088;13372.665683357995;13753.862461375258;733.0763238319649;743.6839343279084;746.7871656577958;764.0907320288838;764.6520833020962;6175.413335733098;6324.620522768649;6365.96817015912;6368.172137622079;6375.936240637627;138534;139078;139319;140989.8230859182;141180;127708;128286.35856820656;128648;129344;131117.03324450142;106819.46590267;106971;107406.46296768467;109305;110465;11779.234349767237;11918.165728399275;11993.400329983291;12032.157748957488;12036.037117030792;51889;52345.45200167871;52432.475675244285;52735;54336.45663543472;63856.36143638504;64119.67940160269;64771;66345.66827165833;67803.3219667797;16197.190140493163;16526.421575244807;16924.49226523157;17222;17261.309547618457;17262.82737172612;17600.73598895992;17629;17661.38185163513;17845.37541186052;15712.92143539275;15995.12026838535;16133.838661613234;16179.51461456111;16327.510174694778;17793.466196014142;21213.363599092052;21755.78244217601;21788.89105554462;21794.128234870426;19799.40601781949;20149.6977545334;20405;21141.154353825674;21721.674174887074;14106.576802695936;14266.785998209827;14358.210298433269;14358.56924292273;14804.276857647968;14866.554003379915;14946.402143914122;14980.43209137038;15218.543443696706;16089.436869709503 11:41:03 INFO - PID 3980 | __end_tp_report 11:41:03 INFO - PID 3980 | __start_cc_report 11:41:03 INFO - PID 3980 | _x_x_mozilla_cycle_collect,351 11:41:03 INFO - PID 3980 | __end_cc_report 11:41:03 INFO - PID 3980 | __startTimestamp1503340863369__endTimestamp 11:41:03 INFO - PID 3980 | 11:41:03 INFO - PID 3980 | ------- Summary: start ------- 11:41:03 INFO - PID 3980 | Number of tests: 6 11:41:03 INFO - PID 3980 | 11:41:03 INFO - PID 3980 | [#0] dojo.html Cycles:165 Average:6252.08 Median:6553.93 stddev:814.85 (12.4%) stddev-sans-first:788.29 11:41:03 INFO - PID 3980 | Values: 3503.0 3520.8 3536.8 3559.8 3573.4 6195.9 6268.2 6316.5 6336.0 6341.1 6164.4 6242.8 6266.1 6360.6 6371.0 5470.9 5472.6 5499.7 5532.3 5567.1 5396.6 5559.9 5599.5 5608.9 5645.9 5493.4 5509.2 5543.3 5552.6 5576.0 5463.5 5499.0 5514.5 5566.9 5570.9 5436.5 5509.2 5541.9 5550.1 5552.9 6208.6 6208.6 6277.2 6311.9 6312.3 6704.2 6747.4 6775.5 6801.8 6909.5 6784.5 6785.4 6849.1 6935.8 6956.4 6310.2 6357.4 6388.1 6413.4 6417.2 6984.9 7002.1 7022.4 7076.0 7123.0 6595.7 6679.9 6711.2 6754.4 6759.3 6835.4 6835.5 6899.3 6907.5 6929.7 6749.5 6750.6 6793.8 6821.7 6839.0 6612.4 6680.0 6682.0 6684.7 6861.0 4870.0 4875.2 4889.2 4929.2 4931.8 4376.0 4391.5 4402.1 4477.4 4500.1 6423.7 6424.9 6443.9 6456.3 6532.0 6682.8 6797.4 6832.2 6896.1 6909.1 6363.0 6380.4 6381.9 6386.3 6388.1 5406.5 5434.9 5459.3 5461.1 5514.4 7130.5 7189.0 7211.5 7215.5 7243.4 6809.1 6833.8 6903.0 6913.3 6919.8 6891.8 6975.5 7091.4 7104.2 7183.6 6680.6 6755.9 6759.5 6760.5 6773.5 6786.7 6856.8 6873.2 6875.5 6875.6 6540.8 6553.9 6561.1 6632.0 6663.6 6484.3 6578.7 6580.6 6593.4 6616.7 6565.0 6565.3 6571.2 6586.2 6600.1 6662.5 6734.9 6753.4 6762.4 6775.2 6460.7 6470.6 6535.5 6538.4 6541.9 11:41:03 INFO - PID 3980 | 11:41:03 INFO - PID 3980 | [#1] ext.html Cycles:180 Average:43801.57 Median:36504.82 stddev:68660.32 (188.1%) stddev-sans-first:68777.23 11:41:03 INFO - PID 3980 | Values: 859.3 928.2 960.3 1317.1 1338.2 40966.4 41885.2 41939.4 41976.4 41994.4 39656.0 39976.4 40001.0 40058.8 40090.8 6887.9 6967.3 6967.7 6971.7 6975.8 7082.3 7167.8 7168.2 7172.8 7181.9 7173.6 7222.1 7532.6 7712.7 7713.2 7615.5 7671.5 7677.3 7681.2 7681.7 7315.3 7497.3 7580.6 7668.9 7675.1 39366.6 39648.4 39754.4 39851.0 39872.2 3483.8 3517.9 3542.8 3545.9 3551.8 30982.2 31114.5 31254.8 31301.0 31325.5 5119.8 5120.2 5136.1 5140.5 5157.9 260959.0 261030.0 262494.0 263123.0 263200.0 49619.0 49825.3 49884.0 50046.0 50759.7 53575.2 53627.7 53961.2 53970.0 54128.7 16196.3 16196.9 16205.6 16206.3 16258.6 12995.6 13007.7 13008.2 13021.4 13034.9 13193.7 14630.7 14733.5 14774.3 14854.4 5214.3 5813.4 5910.1 5911.6 5972.3 1098.9 1111.6 1117.2 1118.9 1129.3 24833.6 24836.5 24911.0 24942.9 25094.0 1210.8 1211.3 1216.1 1229.2 1234.1 17050.0 17245.0 17453.4 17453.6 17557.2 281398.0 282610.0 282853.0 283529.0 284149.0 58300.7 58645.0 58949.0 58950.7 58974.0 1503.9 1543.6 1557.9 1561.1 1566.6 28709.4 28960.4 29291.6 29569.7 30106.1 39980.8 40112.0 40193.4 40211.4 40269.2 242282.0 243532.0 243870.0 247140.0 248465.0 38030.8 38253.8 38313.4 38374.2 38374.8 47078.8 47080.1 47125.8 47503.3 47825.0 35915.5 35962.8 36201.3 36326.5 36631.0 35788.3 35915.3 35925.8 36038.3 36378.6 39559.4 40836.4 40855.8 40915.2 41183.2 34139.8 34253.3 34308.7 34594.5 35414.5 25408.5 26692.3 27285.6 27452.6 27461.2 11:41:03 INFO - PID 3980 | 11:41:03 INFO - PID 3980 | [#2] jquery.html Cycles:180 Average:40918.10 Median:2195.16 stddev:106174.85 (4836.8%) stddev-sans-first:106429.47 11:41:03 INFO - PID 3980 | Values: 568.5 569.6 584.1 584.2 584.4 22814.2 23566.4 23571.6 23597.6 23601.5 25388.0 28041.0 28102.0 28102.4 28208.3 6022.1 6144.4 6155.0 6155.1 6155.7 6046.5 6207.2 6267.1 6341.3 6356.0 6311.8 6315.7 6316.1 6317.2 6321.8 6299.9 6301.7 6304.4 6305.6 6318.2 5853.3 5856.1 5861.6 5864.6 5865.8 30048.8 31063.1 31736.0 31754.4 31936.0 2165.4 2193.9 2194.2 2194.6 2195.7 20266.5 20837.9 20849.8 20854.4 20876.1 2444.5 2480.1 2516.3 2545.4 2548.8 147660.0 150402.0 150673.0 150725.0 150763.0 15194.4 15585.5 15620.9 15689.5 16535.2 24327.0 24332.6 24367.6 24375.8 24391.9 10738.0 10744.0 10929.9 10939.0 10952.2 10130.1 10210.8 10273.2 10275.6 10351.4 8471.9 9941.4 9955.4 10077.0 10084.2 2765.8 2772.0 2772.2 2801.6 2849.3 1043.3 1068.8 1074.6 1075.5 1079.3 22212.2 22272.3 22625.5 23011.3 23110.1 1093.5 1151.4 1159.7 1163.4 1164.2 11964.0 12525.2 12551.6 12632.9 12674.9 620827.0 627915.0 632743.0 646487.0 647248.0 135801.0 136316.0 138439.3 141639.0 142588.3 1350.7 1370.4 1381.5 1392.1 1392.2 19605.0 19655.5 19925.7 20168.5 20324.7 61297.4 62169.4 63300.7 64471.4 64993.7 82672.0 82823.6 83294.2 83512.6 84209.6 13219.7 13648.3 14947.7 15272.9 15462.6 24681.4 24904.1 24932.4 25030.4 25136.1 19939.2 20235.2 20288.3 20382.2 20393.9 15687.7 15806.8 16031.0 16518.9 16566.2 18779.2 19175.6 19798.2 19999.1 20041.6 15282.4 15489.8 15566.0 15579.7 15588.8 18806.3 18952.7 20749.0 20915.0 20952.6 11:41:03 INFO - PID 3980 | 11:41:03 INFO - PID 3980 | [#3] mootools.html Cycles:180 Average:10107.06 Median:2491.09 stddev:7455.06 (299.3%) stddev-sans-first:7447.33 11:41:03 INFO - PID 3980 | Values: 1408.3 1444.4 1455.3 1455.8 1466.4 15815.3 16375.7 16384.0 16406.5 16653.6 16748.6 17024.4 17033.1 17038.4 17051.2 2523.2 2587.7 2649.1 2649.3 2650.2 2597.6 2608.3 2619.9 2626.5 2630.8 2535.9 2575.1 2620.1 2620.9 2623.1 2485.7 2496.4 2539.7 2582.3 2584.7 2512.2 2523.2 2527.0 2530.5 2530.9 15841.4 16074.9 16087.8 16112.8 16153.8 7698.1 7908.1 7918.0 7919.5 7921.7 4775.1 4807.0 4914.6 4941.3 4962.2 1901.0 1908.3 1924.7 1964.0 1971.8 28283.4 28419.0 28519.0 28551.0 28923.1 6373.3 6656.2 6715.6 6820.6 6868.2 19173.3 19199.5 19203.4 19208.2 19255.5 8044.5 8170.3 8175.7 8188.5 8195.0 7323.1 7438.5 7456.0 7507.7 7531.9 5264.1 5399.9 5413.5 5438.8 5452.5 1508.4 1508.7 1513.3 1516.0 1531.1 970.4 975.2 989.1 1009.2 1010.3 8444.9 8493.4 8503.3 8507.0 8581.8 718.6 749.2 1034.2 1044.9 1075.9 5756.4 5767.9 5818.4 5915.0 5955.1 23343.2 23382.9 24081.3 24182.3 24442.1 23446.3 23718.4 23887.9 23915.6 23921.4 11740.7 12067.3 12076.8 12081.2 12202.3 8402.4 8967.9 9056.6 9085.5 9258.0 20667.8 20777.6 20858.5 21116.0 21372.9 21129.4 21419.5 21566.2 21689.5 21876.1 13272.2 13333.9 13389.0 13472.5 13472.8 14944.1 14976.3 14996.3 15000.3 15073.4 12216.8 12413.0 12509.3 12622.2 12679.2 11962.8 12302.7 12367.4 12393.1 12573.9 10596.9 10823.4 10827.1 10832.0 10852.4 8408.9 8417.4 8503.4 8559.2 8568.1 8537.5 8661.3 8668.0 8671.4 8674.7 11:41:03 INFO - PID 3980 | 11:41:03 INFO - PID 3980 | [#4] prototype.html Cycles:180 Average:5596.81 Median:6282.03 stddev:1609.21 (25.6%) stddev-sans-first:1567.75 11:41:03 INFO - PID 3980 | Values: 508.5 510.8 532.7 538.0 540.4 6225.9 6242.4 6260.2 6268.8 6284.8 5975.1 6110.8 6115.3 6116.8 6139.7 4750.5 4810.4 4826.1 4849.9 4872.9 4649.7 4778.1 4791.8 4812.7 4830.7 4775.5 4786.8 4796.4 4805.3 4809.0 4794.9 4799.3 4808.3 4815.5 4849.5 4330.9 4336.3 4339.9 4340.6 4348.5 6052.5 6067.8 6079.3 6106.2 6110.2 5768.6 5796.8 5802.0 5831.5 5836.3 6601.4 6623.4 6630.4 6658.5 6661.5 4939.4 4940.3 4943.3 4947.4 4955.9 6933.3 6965.8 7006.9 7069.6 7095.7 5056.2 5063.1 5065.6 5066.9 5072.6 5149.5 5159.6 5167.7 5168.7 5183.1 5754.7 5789.0 5809.5 5811.2 5834.6 6604.9 6622.3 6629.3 6644.2 6679.2 1687.1 1727.2 1743.8 1769.6 1779.5 1233.6 1256.1 1258.3 1271.5 1275.8 6292.7 6306.7 6310.4 6313.1 6338.8 6604.5 6681.0 6733.8 6735.4 6777.7 6264.0 6289.6 6300.6 6319.6 6346.3 3525.5 3539.4 3571.7 3571.8 3606.7 6942.5 6961.0 7050.4 7072.9 7155.4 6845.1 6876.6 6911.4 6932.0 7017.8 7052.2 7056.9 7072.0 7143.0 7151.3 6712.2 6720.8 6772.9 6807.9 6830.6 6593.8 6702.8 6706.7 6723.3 6794.4 7019.4 7021.8 7090.5 7105.0 7149.0 5093.6 5109.1 5110.5 5120.6 5124.9 6796.4 6803.9 6821.0 6821.2 6838.0 6477.9 6512.7 6564.1 6585.7 6587.6 6402.0 6497.0 6553.2 6566.0 6630.3 6371.8 6427.5 6486.0 6494.7 6557.2 6537.5 6560.8 6607.9 6635.4 6642.9 6279.3 6344.2 6393.5 6403.2 6410.2 11:41:03 INFO - PID 3980 | 11:41:03 INFO - PID 3980 | [#5] yui.html Cycles:180 Average:27294.61 Median:17870.74 stddev:39842.04 (222.9%) stddev-sans-first:39904.65 11:41:03 INFO - PID 3980 | Values: 936.2 943.7 945.5 951.6 963.4 16897.4 16905.5 16912.9 16930.6 21863.0 22388.6 22517.1 22680.8 22729.0 22804.5 1011.3 1030.1 1030.9 1032.0 1033.5 1048.1 1077.2 1086.0 1089.6 1092.4 1138.4 1138.8 1139.2 1139.2 1140.0 1141.4 1143.7 1144.0 1145.1 1145.6 827.1 827.5 828.4 830.6 835.7 20234.6 20430.6 20527.7 20677.0 20865.4 21693.6 21896.0 22338.8 22532.3 22767.3 17647.3 17803.7 17896.1 17963.4 18267.6 3760.0 3764.5 3778.8 3791.0 3811.9 149049.3 150052.0 150276.0 150394.0 150447.0 17182.5 17239.6 17655.6 17666.7 18071.4 32941.3 33228.2 33347.2 33449.5 33613.8 8392.9 8731.3 8907.6 9293.8 9582.3 4685.9 4695.0 4780.8 4782.1 4794.5 5697.5 5734.4 5796.6 5799.5 5815.9 1085.8 1097.0 1116.6 1119.9 1124.8 719.2 725.6 735.4 753.2 754.0 13161.4 13162.4 13364.8 13372.7 13753.9 733.1 743.7 746.8 764.1 764.7 6175.4 6324.6 6366.0 6368.2 6375.9 138534.0 139078.0 139319.0 140989.8 141180.0 127708.0 128286.4 128648.0 129344.0 131117.0 106819.5 106971.0 107406.5 109305.0 110465.0 11779.2 11918.2 11993.4 12032.2 12036.0 51889.0 52345.5 52432.5 52735.0 54336.5 63856.4 64119.7 64771.0 66345.7 67803.3 16197.2 16526.4 16924.5 17222.0 17261.3 17262.8 17600.7 17629.0 17661.4 17845.4 15712.9 15995.1 16133.8 16179.5 16327.5 17793.5 21213.4 21755.8 21788.9 21794.1 19799.4 20149.7 20405.0 21141.2 21721.7 14106.6 14266.8 14358.2 14358.6 14804.3 14866.6 14946.4 14980.4 15218.5 16089.4 11:41:03 INFO - PID 3980 | -------- Summary: end -------- 11:41:03 INFO - PID 3980 | 11:41:04 INFO - TEST-INFO | 3980: exit 0 11:41:04 INFO - TEST-OK | dromaeo_css | took 1112580ms 11:41:04 INFO - TEST-START | kraken 11:41:04 INFO - Initialising browser for kraken test... 11:41:04 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:39755/getInfo.html -profile /tmp/tmpzITBFR/profile 11:41:04 INFO - TEST-INFO | started process 4394 (/builds/slave/test/build/application/firefox/firefox http://localhost:39755/getInfo.html) 11:41:09 INFO - TEST-INFO | 4394: exit 0 11:41:09 INFO - Browser initialized. 11:41:09 INFO - Running cycle 1/1 for kraken test... 11:41:09 INFO - TEST-INFO | started process 4566 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpzITBFR/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 11:41:10 INFO - PID 4566 | 11:41:10 INFO - PID 4566 | (/builds/slave/test/build/application/firefox/firefox:4615): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 11:41:10 INFO - PID 4566 | 11:41:11 INFO - PID 4566 | 11:41:11 INFO - PID 4566 | (/builds/slave/test/build/application/firefox/firefox:4671): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 11:41:11 INFO - PID 4566 | 11:41:11 INFO - PID 4566 | __metrics Screen width/height:1600/1200 11:41:11 INFO - PID 4566 | colorDepth:24 11:41:11 INFO - PID 4566 | Browser inner width/height: 1024/768 11:41:11 INFO - PID 4566 | __metrics 11:41:20 INFO - PID 4566 | RSS: Main: 165359616 11:41:20 INFO - PID 4566 | 11:41:23 INFO - PID 4566 | Cycle 1(1): loaded http://localhost:39755/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:39755/tests/kraken/driver.html?testName=audio-beat-detection) 11:41:24 INFO - PID 4566 | RSS: Main: 169484288 11:41:24 INFO - PID 4566 | 11:41:26 INFO - PID 4566 | Cycle 1(1): loaded http://localhost:39755/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:39755/tests/kraken/driver.html?testName=audio-dft) 11:41:27 INFO - PID 4566 | RSS: Main: 171917312 11:41:27 INFO - PID 4566 | 11:41:30 INFO - PID 4566 | Cycle 1(1): loaded http://localhost:39755/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:39755/tests/kraken/driver.html?testName=audio-fft) 11:41:31 INFO - PID 4566 | RSS: Main: 165703680 11:41:31 INFO - PID 4566 | 11:41:33 INFO - PID 4566 | Cycle 1(1): loaded http://localhost:39755/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:39755/tests/kraken/driver.html?testName=audio-oscillator) 11:41:33 INFO - PID 4566 | RSS: Main: 166940672 11:41:33 INFO - PID 4566 | 11:41:35 INFO - PID 4566 | Cycle 1(1): loaded http://localhost:39755/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:39755/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:41:36 INFO - PID 4566 | RSS: Main: 166391808 11:41:36 INFO - PID 4566 | 11:41:39 INFO - PID 4566 | Cycle 1(1): loaded http://localhost:39755/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:39755/tests/kraken/driver.html?testName=imaging-darkroom) 11:41:40 INFO - PID 4566 | RSS: Main: 166801408 11:41:40 INFO - PID 4566 | 11:41:43 INFO - PID 4566 | Cycle 1(1): loaded http://localhost:39755/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:39755/tests/kraken/driver.html?testName=imaging-desaturate) 11:41:44 INFO - PID 4566 | RSS: Main: 168529920 11:41:44 INFO - PID 4566 | 11:41:46 INFO - PID 4566 | Cycle 1(1): loaded http://localhost:39755/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:39755/tests/kraken/driver.html?testName=json-parse-financial) 11:41:47 INFO - PID 4566 | RSS: Main: 168947712 11:41:47 INFO - PID 4566 | 11:41:49 INFO - PID 4566 | Cycle 1(1): loaded http://localhost:39755/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:39755/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:41:49 INFO - PID 4566 | RSS: Main: 168800256 11:41:49 INFO - PID 4566 | 11:41:51 INFO - PID 4566 | Cycle 1(1): loaded http://localhost:39755/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:39755/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:41:52 INFO - PID 4566 | RSS: Main: 168951808 11:41:52 INFO - PID 4566 | 11:41:54 INFO - PID 4566 | Cycle 1(1): loaded http://localhost:39755/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:39755/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:41:54 INFO - PID 4566 | RSS: Main: 168554496 11:41:54 INFO - PID 4566 | 11:41:57 INFO - PID 4566 | Cycle 1(1): loaded http://localhost:39755/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:39755/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:41:58 INFO - PID 4566 | RSS: Main: 168464384 11:41:58 INFO - PID 4566 | 11:42:00 INFO - PID 4566 | Cycle 1(1): loaded http://localhost:39755/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:39755/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:42:01 INFO - PID 4566 | RSS: Main: 169496576 11:42:01 INFO - PID 4566 | 11:42:03 INFO - PID 4566 | Cycle 1(1): loaded http://localhost:39755/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:39755/tests/kraken/driver.html?testName=ai-astar) 11:42:03 INFO - PID 4566 | RSS: Main: 170782720 11:42:03 INFO - PID 4566 | 11:42:03 INFO - PID 4566 | __start_tp_report 11:42:03 INFO - PID 4566 | _x_x_mozilla_page_load 11:42:03 INFO - PID 4566 | _x_x_mozilla_page_load_details 11:42:03 INFO - PID 4566 | |i|pagename|runs| 11:42:03 INFO - PID 4566 | |0;ai-astar;101;107;96;106;105;107;109;107;105;108 11:42:03 INFO - PID 4566 | |1;audio-beat-detection;140;115;138;166;113;139;143;115;175;117 11:42:03 INFO - PID 4566 | |2;audio-dft;163;162;162;161;161;163;160;160;165;168 11:42:03 INFO - PID 4566 | |3;audio-fft;75;74;74;151;75;73;72;88;94;75 11:42:03 INFO - PID 4566 | |4;audio-oscillator;79;78;123;78;78;78;126;78;79;122 11:42:03 INFO - PID 4566 | |5;imaging-gaussian-blur;115;115;114;113;117;114;115;113;114;114 11:42:03 INFO - PID 4566 | |6;imaging-darkroom;147;147;152;149;150;148;148;148;150;147 11:42:03 INFO - PID 4566 | |7;imaging-desaturate;94;94;94;96;94;94;93;94;94;95 11:42:03 INFO - PID 4566 | |8;json-parse-financial;48;48;47;48;49;53;48;47;47;47 11:42:03 INFO - PID 4566 | |9;json-stringify-tinderbox;55;54;57;55;56;55;54;54;55;56 11:42:03 INFO - PID 4566 | |10;stanford-crypto-aes;75;73;72;71;73;72;86;73;72;73 11:42:03 INFO - PID 4566 | |11;stanford-crypto-ccm;128;122;112;112;118;112;131;112;112;160 11:42:03 INFO - PID 4566 | |12;stanford-crypto-pbkdf2;168;167;160;162;162;161;162;166;163;160 11:42:03 INFO - PID 4566 | |13;stanford-crypto-sha256-iterative;62;63;65;61;61;63;62;62;62;67 11:42:03 INFO - PID 4566 | __end_tp_report 11:42:03 INFO - PID 4566 | __start_cc_report 11:42:03 INFO - PID 4566 | _x_x_mozilla_cycle_collect,859 11:42:03 INFO - PID 4566 | __end_cc_report 11:42:03 INFO - PID 4566 | __startTimestamp1503340923363__endTimestamp 11:42:03 INFO - PID 4566 | 11:42:03 INFO - PID 4566 | ------- Summary: start ------- 11:42:03 INFO - PID 4566 | Number of tests: 14 11:42:03 INFO - PID 4566 | 11:42:03 INFO - PID 4566 | [#0] ai-astar Cycles:10 Average:105.10 Median:107.00 stddev:3.87 (3.6%) stddev-sans-first:3.81 11:42:03 INFO - PID 4566 | Values: 101.0 107.0 96.0 106.0 105.0 107.0 109.0 107.0 105.0 108.0 11:42:03 INFO - PID 4566 | 11:42:03 INFO - PID 4566 | [#1] audio-beat-detection Cycles:10 Average:136.10 Median:139.50 stddev:21.78 (15.6%) stddev-sans-first:23.06 11:42:03 INFO - PID 4566 | Values: 140.0 115.0 138.0 166.0 113.0 139.0 143.0 115.0 175.0 117.0 11:42:03 INFO - PID 4566 | 11:42:03 INFO - PID 4566 | [#2] audio-dft Cycles:10 Average:162.50 Median:162.50 stddev:2.46 (1.5%) stddev-sans-first:2.60 11:42:03 INFO - PID 4566 | Values: 163.0 162.0 162.0 161.0 161.0 163.0 160.0 160.0 165.0 168.0 11:42:03 INFO - PID 4566 | 11:42:03 INFO - PID 4566 | [#3] audio-fft Cycles:10 Average:85.10 Median:75.00 stddev:24.27 (32.4%) stddev-sans-first:25.46 11:42:03 INFO - PID 4566 | Values: 75.0 74.0 74.0 151.0 75.0 73.0 72.0 88.0 94.0 75.0 11:42:03 INFO - PID 4566 | 11:42:03 INFO - PID 4566 | [#4] audio-oscillator Cycles:10 Average:91.90 Median:78.00 stddev:21.95 (28.1%) stddev-sans-first:22.78 11:42:03 INFO - PID 4566 | Values: 79.0 78.0 123.0 78.0 78.0 78.0 126.0 78.0 79.0 122.0 11:42:03 INFO - PID 4566 | 11:42:03 INFO - PID 4566 | [#5] imaging-gaussian-blur Cycles:10 Average:114.40 Median:114.50 stddev:1.17 (1.0%) stddev-sans-first:1.22 11:42:03 INFO - PID 4566 | Values: 115.0 115.0 114.0 113.0 117.0 114.0 115.0 113.0 114.0 114.0 11:42:03 INFO - PID 4566 | 11:42:03 INFO - PID 4566 | [#6] imaging-darkroom Cycles:10 Average:148.60 Median:148.50 stddev:1.65 (1.1%) stddev-sans-first:1.64 11:42:03 INFO - PID 4566 | Values: 147.0 147.0 152.0 149.0 150.0 148.0 148.0 148.0 150.0 147.0 11:42:03 INFO - PID 4566 | 11:42:03 INFO - PID 4566 | [#7] imaging-desaturate Cycles:10 Average:94.20 Median:94.00 stddev:0.79 (0.8%) stddev-sans-first:0.83 11:42:03 INFO - PID 4566 | Values: 94.0 94.0 94.0 96.0 94.0 94.0 93.0 94.0 94.0 95.0 11:42:03 INFO - PID 4566 | 11:42:03 INFO - PID 4566 | [#8] json-parse-financial Cycles:10 Average:48.20 Median:48.00 stddev:1.81 (3.8%) stddev-sans-first:1.92 11:42:03 INFO - PID 4566 | Values: 48.0 48.0 47.0 48.0 49.0 53.0 48.0 47.0 47.0 47.0 11:42:03 INFO - PID 4566 | 11:42:03 INFO - PID 4566 | [#9] json-stringify-tinderbox Cycles:10 Average:55.10 Median:55.00 stddev:0.99 (1.8%) stddev-sans-first:1.05 11:42:03 INFO - PID 4566 | Values: 55.0 54.0 57.0 55.0 56.0 55.0 54.0 54.0 55.0 56.0 11:42:03 INFO - PID 4566 | 11:42:03 INFO - PID 4566 | [#10] stanford-crypto-aes Cycles:10 Average:74.00 Median:73.00 stddev:4.35 (6.0%) stddev-sans-first:4.59 11:42:03 INFO - PID 4566 | Values: 75.0 73.0 72.0 71.0 73.0 72.0 86.0 73.0 72.0 73.0 11:42:03 INFO - PID 4566 | 11:42:03 INFO - PID 4566 | [#11] stanford-crypto-ccm Cycles:10 Average:121.90 Median:120.00 stddev:15.19 (12.7%) stddev-sans-first:15.95 11:42:03 INFO - PID 4566 | Values: 128.0 122.0 112.0 112.0 118.0 112.0 131.0 112.0 112.0 160.0 11:42:03 INFO - PID 4566 | 11:42:03 INFO - PID 4566 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:163.10 Median:162.50 stddev:2.88 (1.8%) stddev-sans-first:2.46 11:42:03 INFO - PID 4566 | Values: 168.0 167.0 160.0 162.0 162.0 161.0 162.0 166.0 163.0 160.0 11:42:03 INFO - PID 4566 | 11:42:03 INFO - PID 4566 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.80 Median:62.50 stddev:1.87 (3.0%) stddev-sans-first:1.96 11:42:03 INFO - PID 4566 | Values: 62.0 63.0 65.0 61.0 61.0 63.0 62.0 62.0 62.0 67.0 11:42:03 INFO - PID 4566 | -------- Summary: end -------- 11:42:03 INFO - PID 4566 | 11:42:03 INFO - PID 4566 | 11:42:03 INFO - PID 4566 | ###!!! [Parent][MessageChannel] Error: (msgtype=0x150079,name=PBrowser::Msg_Destroy) Closed channel: cannot send/recv 11:42:03 INFO - PID 4566 | 11:42:03 INFO - PID 4566 | 11:42:03 INFO - PID 4566 | ###!!! [Child][MessageChannel] Error: (msgtype=0x150001,name=PBrowser::Msg_AsyncMessage) Closed channel: cannot send/recv 11:42:03 INFO - PID 4566 | 11:42:03 INFO - PID 4566 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 11:42:04 INFO - TEST-INFO | 4566: exit 0 11:42:04 INFO - TEST-OK | kraken | took 60044ms 11:42:04 INFO - SUITE-END | took 1172s 11:42:04 INFO - Completed test suite (00:19:33) 11:42:04 INFO - javascript benchmark 11:42:04 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8964.008159176188, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3502.9824850875743, 3520.823958802059, 3536.7524273300864, 3559.8220088995554, 3573.3746594345985, 6195.938040619592, 6268.216472940882, 6316.5262605304615, 6335.9683201583985, 6341.080543321215, 6164.383561643834, 6242.812715618527, 6266.091416744569, 6360.618362898218, 6371.0, 5470.890582188354, 5472.5621950243985, 5499.697516636584, 5532.253145825302, 5567.053600887839, 5396.568274538027, 5559.8888022239535, 5599.496045355917, 5608.915866261989, 5645.8588535286535, 5493.395726470085, 5509.173623956399, 5543.279373681436, 5552.611317207777, 5575.972120139414, 5463.480969307949, 5498.972505137489, 5514.531264842493, 5566.916496252559, 5570.888582228374, 5436.483534064258, 5509.173623956399, 5541.861453463655, 5550.139728342114, 5552.888942221173, 6208.627482351028, 6208.627482351028, 6277.246730392382, 6311.905321420182, 6312.305646378894, 6704.229013663394, 6747.359000894907, 6775.457963362919, 6801.829954251183, 6909.481788865855, 6784.457243420515, 6785.423239024689, 6849.1438570178725, 6935.826604334881, 6956.443484521226, 6310.211223597004, 6357.364263573651, 6388.105665206875, 6413.358664133596, 6417.197850268716, 6984.930150698428, 7002.124734408199, 7022.438204943593, 7076.044733960953, 7122.964385178041, 6595.670216489157, 6679.86640267192, 6711.161104861892, 6754.3921047106, 6759.256481787098, 6835.4189893859575, 6835.521513494008, 6899.344562266577, 6907.516473846883, 6929.688164032631, 6749.493787965922, 6750.594964302158, 6793.830154246085, 6821.658917054127, 6839.0425340452375, 6612.371824676648, 6679.998000299896, 6682.0311054896765, 6684.699188536528, 6860.965695171492, 4869.975650121727, 4875.19559272716, 4889.168841296988, 4929.211326187793, 4931.827386041471, 4375.9935214900115, 4391.538888416734, 4402.141582391467, 4477.3731677565165, 4500.099980003947, 6423.710933008026, 6424.935750642434, 6443.936750436219, 6456.289808121103, 6531.967340163269, 6682.766103186365, 6797.388235058868, 6832.180138383425, 6896.103506544117, 6909.1018167638895, 6363.0455431684695, 6380.393862583047, 6381.936180638227, 6386.265579458329, 6388.105665206875, 5406.486383793534, 5434.91847622286, 5459.2902922619805, 5461.0716178249795, 5514.420985796514, 7130.465215108888, 7188.964055179691, 7211.459140564479, 7215.458840586872, 7243.420526357879, 6809.080774095632, 6833.760818371532, 6902.965485172643, 6913.274106218976, 6919.827004324932, 6891.793246202622, 6975.546589471668, 7091.361777439849, 7104.183018952886, 7183.604901730455, 6680.565763225375, 6755.864882702417, 6759.493038022069, 6760.459163267025, 6773.491988100814, 6786.660666966533, 6856.760013399507, 6873.20958089826, 6875.518713689994, 6875.5874647521305, 6540.803775886731, 6553.934460655332, 6561.081448597296, 6632.038354438483, 6663.600183988976, 6484.319146489551, 6578.7368505261165, 6580.605163690194, 6593.3736295051895, 6616.66916654175, 6565.048068030204, 6565.310642382672, 6571.211454625284, 6586.176727909012, 6600.07598936159, 6662.500312476681, 6734.898976515258, 6753.425958793558, 6762.391384775394, 6775.186977562526, 6460.676966151767, 6470.644114573555, 6535.477161827138, 6538.444232240313, 6541.934580654323], "value": 6189.536473449356, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [859.3115959325917, 928.1924725488824, 960.3277705606077, 1317.0648839324078, 1338.2238301784967, 40966.385504217425, 41885.162296754046, 41939.370909436344, 41976.37035444463, 41994.37008444868, 39656.0, 39976.400353994715, 40001.0, 40058.799706001504, 40090.7995460023, 6887.896681549768, 6967.338102880219, 6967.721291148348, 6971.7211311547735, 6975.755848545302, 7082.291770822928, 7167.820804479904, 7168.175659799112, 7172.820679483002, 7181.928180718178, 7173.605451700155, 7222.133343998701, 7532.585707786069, 7712.730054448096, 7713.228677132298, 7615.504992175519, 7671.462997590171, 7677.347425468842, 7681.23187681233, 7681.731139410122, 7315.30504602062, 7497.2877576630135, 7580.620968951531, 7668.923310766932, 7675.078990521118, 39366.60633393658, 39648.405273920915, 39754.403683944765, 39851.0, 39872.202555948716, 3483.756137070406, 3517.9120521986897, 3542.787432754017, 3545.85816567337, 3551.751377403583, 30982.225444363845, 31114.53328200079, 31254.843725781226, 31301.0, 31325.530117048263, 5119.769610367543, 5120.15517439622, 5136.126858434075, 5140.485951404867, 5157.871053223662, 260959.0, 261030.0, 262494.0, 263123.0, 263200.0, 49619.0, 49825.25262121071, 49884.009279257574, 50046.0, 50759.746201268754, 53575.19637205445, 53627.73186134122, 53961.190582140516, 53970.0, 54128.72935635297, 16196.271167797242, 16196.919015404848, 16205.594860128354, 16206.270717817726, 16258.593535161479, 12995.610131696065, 13007.674808129683, 13008.21950682962, 13021.414036368385, 13034.934825325812, 13193.670158245928, 14630.707385852224, 14733.484328048682, 14774.26128693561, 14854.405823766929, 5214.322138122096, 5813.389594092644, 5910.083936989773, 5911.615744976562, 5972.343042265347, 1098.8626421697288, 1111.5998240633367, 1117.1565468071553, 1118.8657361116718, 1129.3224065560762, 24833.62749558758, 24836.503269934863, 24911.0, 24942.875285623457, 25094.0, 1210.8375959079383, 1211.2732360583755, 1216.0697066743949, 1229.1764517773113, 1234.062112794265, 17050.0, 17245.0, 17453.38913138034, 17453.563660908578, 17557.20992555338, 281398.0, 282610.0, 282853.0, 283529.0, 284149.0, 58300.70849645725, 58645.0, 58949.0, 58950.705246473495, 58974.0, 1503.864652181287, 1543.6063803729976, 1557.8753699703996, 1561.0555613853683, 1566.5848550134224, 28709.425811483237, 28960.42079158447, 29291.56062659019, 29569.704302956696, 30106.096817095524, 39980.80009599934, 40112.0, 40193.39709904295, 40211.39682904817, 40269.19461610693, 242282.0, 243532.0, 243870.0, 247140.0, 248465.0, 38030.80984595059, 38253.80873095617, 38313.425298619986, 38374.23251534898, 38374.80812595919, 47078.76460617675, 47080.05839883115, 47125.764371177924, 47503.287450687574, 47825.0, 35915.46126808048, 35962.820185898905, 36201.27597447984, 36326.455103174005, 36631.0, 35788.28423431569, 35915.28169436545, 35925.820370899026, 36038.27923441569, 36378.636213637525, 39559.40660890147, 40836.38745418881, 40855.79572102239, 40915.18169636531, 41183.176336473705, 34139.82930085334, 34253.31493370169, 34308.65691343055, 34594.48108278428, 35414.468782967764, 25408.491830162922, 26692.332691682863, 27285.59071613967, 27452.588211176448, 27461.17616471509], "value": 18507.376794739765, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [568.5161727890206, 569.5842035314221, 584.0917373484233, 584.2463222443049, 584.3980699879125, 22814.20150294738, 23566.410839729015, 23571.646425303636, 23597.64603530944, 23601.5279694406, 25388.0, 28041.018564350252, 28102.0, 28102.43795124096, 28208.294792630142, 6022.126791615224, 6144.385561443843, 6154.969225153868, 6155.138280640714, 6155.7229924653275, 6046.486048685867, 6207.193064901557, 6267.05994100884, 6341.2707538633185, 6355.968220158893, 6311.77908773193, 6315.652639104847, 6316.052592111198, 6317.178766760315, 6321.77873774418, 6299.905501417483, 6301.684915754194, 6304.369563043705, 6305.621662700252, 6318.241810982689, 5853.326867410217, 5856.121581762727, 5861.589688721791, 5864.648121112704, 5865.794697185578, 30048.849755751082, 31063.136211827135, 31736.0, 31754.364912701847, 31936.0, 2165.4261620670536, 2193.9451513712124, 2194.2429861697688, 2194.6378847490146, 2195.6816261642134, 20266.49333766653, 20837.895810521, 20849.791502084936, 20854.37436876881, 20876.06057727406, 2444.5477586646525, 2480.1195575570773, 2516.30801529579, 2545.376382786211, 2548.7578680025554, 147660.0, 150402.0, 150673.0, 150725.0, 150763.0, 15194.392224310905, 15585.454509092127, 15620.921895390451, 15689.529314120595, 16535.173241337885, 24327.0, 24332.635010474856, 24367.634485482733, 24375.75624243735, 24391.878040609685, 10738.0, 10744.0, 10929.890701093047, 10939.015488605904, 10952.233343666026, 10130.138938190188, 10210.795784084277, 10273.178145748323, 10275.588976441008, 10351.378917264989, 8471.872921906177, 9941.353812002197, 9955.402675839472, 10077.0, 10084.193264538819, 2765.778737700979, 2771.9861400692866, 2772.1683494951435, 2801.607774911514, 2849.259192609895, 1043.3062013760764, 1068.8396740488834, 1074.5809134437575, 1075.5482697267166, 1079.2660990526517, 22212.222572209896, 22272.331830045125, 22625.547489050456, 23011.309660710205, 23110.075596975934, 1093.5461783359976, 1151.424287856072, 1159.652104368686, 1163.3717792392013, 1164.231607139284, 11964.0, 12525.185862918881, 12551.560695375618, 12632.873671263353, 12674.936625316814, 620827.0, 627915.0, 632743.0, 646487.0, 647248.0, 135801.0, 136316.0, 138439.30780346034, 141639.0, 142588.28705856611, 1350.6758377989408, 1370.3833275026277, 1381.5233744358181, 1392.1020941492884, 1392.1577445645441, 19605.0, 19655.508612284808, 19925.701114483003, 20168.49578760543, 20324.695129572774, 61297.38702613095, 62169.37830621636, 63300.68349658222, 64471.35528644654, 64993.67503162643, 82672.0, 82823.5858820702, 83294.16705832865, 83512.58243708743, 84209.5789521073, 13219.66950826237, 13648.317584120952, 14947.701045978802, 15272.923635381752, 15462.613434664223, 24681.382965426008, 24904.12835550747, 24932.37669058288, 25030.3742406434, 25136.12023579166, 19939.20243190314, 20235.19059237673, 20288.289909853083, 20382.184712611328, 20393.898030509754, 15687.68624627524, 15806.7628985563, 16031.0, 16518.917405413376, 16566.17169141562, 18779.15493802755, 19175.616487670446, 19798.20807167697, 19999.10004049792, 20041.599168016266, 15282.388704452142, 15489.767653484982, 15566.0, 15579.688406231586, 15588.84411155874, 18806.341778037702, 18952.71570926465, 20749.0, 20915.0, 20952.58094838125], "value": 12765.534671644327, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1408.2677007955863, 1444.3500424808838, 1455.3305479479432, 1455.832579253385, 1466.4354223623905, 15815.288312025958, 16375.672486550262, 16384.016958982455, 16406.507804765846, 16653.583660408494, 16748.58128546787, 17024.404145854896, 17033.063181525013, 17038.403655872047, 17051.232694528746, 2523.205190365029, 2587.6636037315125, 2649.1125472966482, 2649.297936046949, 2650.2446802661248, 2597.649317342163, 2608.2566468556465, 2619.9214023579325, 2626.4747050589863, 2630.789536837048, 2535.911243106492, 2575.111586502663, 2620.1484517531785, 2620.8689565521745, 2623.108143231301, 2485.7389974052735, 2496.4383013821925, 2539.669842920418, 2582.289870285668, 2584.6769153855766, 2512.208654273898, 2523.1799665108915, 2526.9620955685496, 2530.5065512224937, 2530.911418100376, 15841.366345346172, 16074.919625401915, 16087.758683619755, 16112.75830862538, 16153.757693634605, 7698.076230852277, 7908.090569584514, 7918.0, 7919.485233459806, 7921.722739704141, 4775.068861571995, 4806.975965120152, 4914.606831453475, 4941.308216849644, 4962.1812400953795, 1900.9904950475159, 1908.3034692337335, 1924.6535623587888, 1963.980360196394, 1971.822535971755, 28283.434331313463, 28419.0, 28519.0, 28551.0, 28923.132306030642, 6373.298937116913, 6656.2345330287635, 6715.630640314829, 6820.556663816836, 6868.244493105754, 19173.32893348726, 19199.52001199981, 19203.423897283104, 19208.231670733014, 19255.51861203453, 8044.517328960281, 8170.305524030524, 8175.7138500152205, 8188.5496297703, 8194.959025204837, 7323.121225452873, 7438.516496427715, 7456.0, 7507.737229197061, 7531.887021694679, 5264.131418316011, 5399.919001214985, 5413.485718856702, 5438.755256013489, 5452.509274165344, 1508.3966413434493, 1508.7133444645483, 1513.3341329814846, 1515.9545213643607, 1531.1425601663104, 970.4080510888352, 975.2441857560448, 989.094978095035, 1009.2430676992255, 1010.2978429991085, 8444.929899899667, 8493.447925884797, 8503.319734421231, 8507.0, 8581.78545536354, 718.6406796601699, 749.2058418076856, 1034.1881622925966, 1044.9373037617768, 1075.876274228458, 5756.429576551162, 5767.942320576824, 5818.44724751148, 5915.0, 5955.13650520672, 23343.18298859532, 23382.883085584803, 24081.277561673178, 24182.274531764077, 24442.14452494154, 23446.296611101694, 23718.407039823796, 23887.880560597085, 23915.641265381033, 23921.401964951016, 11740.708522062567, 12067.275963442222, 12076.818847717292, 12081.154319197747, 12202.267863928193, 8402.41183117176, 8967.910320896968, 9056.592453339485, 9085.454872707658, 9258.0, 20667.793322066587, 20777.58444831065, 20858.47853803667, 21116.04977775973, 21372.89313553422, 21129.36611901584, 21419.46451338729, 21566.245181418573, 21689.457763556038, 21876.124955001622, 13272.203667779964, 13333.866581346938, 13389.0, 13472.5284615038, 13472.79790803119, 14944.103353798806, 14976.326065327305, 14996.325165367803, 15000.324985375466, 15073.397064117313, 12216.816747748613, 12413.006959443042, 12509.311987840756, 12622.179558328678, 12679.175853569488, 11962.760744784882, 12302.692432689255, 12367.443465044274, 12393.132480726263, 12573.874261257637, 10596.8940310599, 10823.350598964087, 10827.07969822574, 10832.0, 10852.403117828595, 8408.915910841059, 8417.410781245499, 8503.362247831561, 8559.22966932979, 8568.100349463466, 8537.53043582609, 8661.263792577702, 8667.956660216658, 8671.393002489765, 8674.739757807276], "value": 7027.435768617999, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [508.48388885281446, 510.82121257559857, 532.7362955337109, 537.9731013449327, 540.4433433563429, 6225.906611400827, 6242.438180563749, 6260.248770147588, 6268.843278918023, 6284.780032698856, 5975.073863551145, 6110.816675499731, 6115.296740874801, 6116.755329786814, 6139.662318572477, 4750.501197374278, 4810.374651295327, 4826.107170173529, 4849.903001939959, 4872.926906096393, 4649.744264065475, 4778.1126455050235, 4791.808327666889, 4812.6552046327815, 4830.661853670244, 4775.474697783241, 4786.784594693229, 4796.400449943757, 4805.303231031498, 4808.951910480885, 4794.9280760788615, 4799.328094066834, 4808.254720518308, 4815.49437309081, 4849.539293767087, 4330.891727706801, 4336.349547567858, 4339.869803905856, 4340.567612687837, 4348.456442944632, 6052.515798736091, 6067.848303792396, 6079.300880398767, 6106.206193194901, 6110.175126357974, 5768.596198266123, 5796.768244225961, 5802.0, 5831.504322132624, 5836.2996440427, 6601.405873471411, 6623.437007854338, 6630.370114839083, 6658.500612454037, 6661.467082633426, 4939.3578834751615, 4940.3330550375595, 4943.332650092263, 4947.381577302837, 4955.876103097416, 6933.341332573397, 6965.756198533027, 7006.894896576556, 7069.611171385572, 7095.7161713531395, 5056.165732654071, 5063.11395505785, 5065.594752419871, 5066.873328166752, 5072.644914855925, 5149.48505149482, 5159.561437277874, 5167.741612919414, 5168.664036837594, 5183.118869792144, 5754.676424422322, 5789.015867302569, 5809.50619197373, 5811.215485909433, 5834.649921004753, 6604.86790264192, 6622.304658010936, 6629.303923088007, 6644.202695676453, 6679.2318883329035, 1687.147990264933, 1727.2400143936627, 1743.8256174382461, 1769.575301927528, 1779.4572655340246, 1233.5559198688466, 1256.0705078242217, 1258.2576279994846, 1271.5295340723992, 1275.776739070659, 6292.716827742671, 6306.747730090837, 6310.43206111443, 6313.05304204373, 6338.8415289617205, 6604.504662150358, 6680.966595166993, 6733.797986060426, 6735.4274886635185, 6777.661116944231, 6263.96868015657, 6289.591176573508, 6300.621962682254, 6319.557630965788, 6346.27017892939, 3525.453554699026, 3539.43369060949, 3571.714262858965, 3571.767835090711, 3606.6573675500786, 6942.51402401827, 6961.0, 7050.365467107985, 7072.929270707227, 7155.427565794828, 6845.110135682329, 6876.587404755731, 6911.40391639554, 6931.965340173368, 7017.824554386079, 7052.153741550842, 7056.894146587805, 7071.964640176869, 7142.964285178645, 7151.284871512911, 6712.194536655633, 6720.764773232913, 6772.86454270902, 6807.897881531682, 6830.633873225275, 6593.835154121185, 6702.798916032527, 6706.731730730911, 6723.2940541244425, 6794.388505034571, 7019.3682568569075, 7021.754238601625, 7090.4682148840075, 7105.0, 7148.964255178691, 5093.567046801063, 5109.131447653982, 5110.488951105009, 5120.564751996122, 5124.923126153185, 6796.35434633709, 6803.93196068033, 6820.965895170492, 6821.1814582250445, 6837.965810170917, 6477.902831457626, 6512.706928188148, 6564.142534524513, 6585.670716464253, 6587.63767992765, 6401.967990160019, 6496.967515162394, 6553.246376666553, 6566.0, 6630.30381809903, 6371.840703982438, 6427.453666438405, 6485.967570162119, 6494.74021039172, 6557.180352455943, 6537.542372033912, 6560.8359791005605, 6607.867842643024, 6635.402813746786, 6642.9217266200885, 6279.277883043508, 6344.206974128234, 6393.4885209184085, 6403.167588213502, 6410.1987251593555], "value": 5125.184681336065, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [936.1761649748223, 943.6508491858009, 945.4941606240658, 951.5908159491416, 963.4412041016213, 16897.408590699328, 16905.492835214933, 16912.91543542282, 16930.576735581602, 21863.0, 22388.55222895545, 22517.09931602734, 22680.773192268072, 22729.0, 22804.54390912185, 1011.2870426349443, 1030.1449796668746, 1030.8814486334093, 1031.988651121901, 1033.5452400943598, 1048.1300520567947, 1077.219016213247, 1085.967420977368, 1089.624079692505, 1092.3773449133996, 1138.4478527913955, 1138.8064029115071, 1139.191174266272, 1139.191174266272, 1140.0366690146814, 1141.4463984967285, 1143.6912033750882, 1144.0332918683782, 1145.123980155182, 1145.5646854195395, 827.1315119124955, 827.4662842466576, 828.4366630691128, 830.5722552885269, 835.7033253195088, 20234.595308093754, 20430.591388172154, 20527.692084618742, 20677.0, 20865.37403877886, 21693.56612867734, 21896.0, 22338.776612233833, 22532.324030279116, 22767.31698049061, 17647.294108235656, 17803.73294400585, 17896.105194740212, 17963.371282005068, 18267.634647307113, 3759.9624003759886, 3764.4729737836724, 3778.848846046155, 3791.0, 3811.942820857689, 149049.25475372662, 150052.0, 150276.0, 150394.0, 150447.0, 17182.484525464257, 17239.56901077458, 17655.646887062445, 17666.734998975026, 18071.367502137364, 32941.3411731764, 33228.169295767315, 33347.16632084169, 33449.49825752616, 33613.83193084019, 8392.874106888401, 8731.257843083282, 8907.643694252287, 9293.767655808659, 9582.329236953487, 4685.906281874411, 4695.037517308943, 4780.784864681098, 4782.115308667838, 4794.496577859344, 5697.4587414195585, 5734.39788822176, 5796.565257605696, 5799.507041901401, 5815.94184058154, 1085.8316960871077, 1096.9725756856142, 1116.6370929447799, 1119.92720473169, 1124.7806677697934, 719.2052781676173, 725.5574099799119, 735.3786050787077, 753.2279413601103, 753.9509931854412, 13161.407736651681, 13162.407691653898, 13364.799528007088, 13372.665683357995, 13753.862461375258, 733.0763238319649, 743.6839343279084, 746.7871656577958, 764.0907320288838, 764.6520833020962, 6175.413335733098, 6324.620522768649, 6365.96817015912, 6368.172137622079, 6375.936240637627, 138534.0, 139078.0, 139319.0, 140989.8230859182, 141180.0, 127708.0, 128286.35856820656, 128648.0, 129344.0, 131117.03324450142, 106819.46590267, 106971.0, 107406.46296768467, 109305.0, 110465.0, 11779.234349767237, 11918.165728399275, 11993.400329983291, 12032.157748957488, 12036.037117030792, 51889.0, 52345.45200167871, 52432.475675244285, 52735.0, 54336.45663543472, 63856.36143638504, 64119.67940160269, 64771.0, 66345.66827165833, 67803.3219667797, 16197.190140493163, 16526.421575244807, 16924.49226523157, 17222.0, 17261.309547618457, 17262.82737172612, 17600.73598895992, 17629.0, 17661.38185163513, 17845.37541186052, 15712.92143539275, 15995.12026838535, 16133.838661613234, 16179.51461456111, 16327.510174694778, 17793.466196014142, 21213.363599092052, 21755.78244217601, 21788.89105554462, 21794.128234870426, 19799.40601781949, 20149.6977545334, 20405.0, 21141.154353825674, 21721.674174887074, 14106.576802695936, 14266.785998209827, 14358.210298433269, 14358.56924292273, 14804.276857647968, 14866.554003379915, 14946.402143914122, 14980.43209137038, 15218.543443696706, 16089.436869709503], "value": 9850.028105081316, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1463.0, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 107.0, 96.0, 106.0, 105.0, 107.0, 109.0, 107.0, 105.0, 108.0], "value": 105.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 115.0, 138.0, 166.0, 113.0, 139.0, 143.0, 115.0, 175.0, 117.0], "value": 136.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 162.0, 162.0, 161.0, 161.0, 163.0, 160.0, 160.0, 165.0, 168.0], "value": 162.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 74.0, 151.0, 75.0, 73.0, 72.0, 88.0, 94.0, 75.0], "value": 85.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 78.0, 123.0, 78.0, 78.0, 78.0, 126.0, 78.0, 79.0, 122.0], "value": 91.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 115.0, 114.0, 113.0, 117.0, 114.0, 115.0, 113.0, 114.0, 114.0], "value": 114.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 152.0, 149.0, 150.0, 148.0, 148.0, 148.0, 150.0, 147.0], "value": 148.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 96.0, 94.0, 94.0, 93.0, 94.0, 94.0, 95.0], "value": 94.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [48.0, 48.0, 47.0, 48.0, 49.0, 53.0, 48.0, 47.0, 47.0, 47.0], "value": 48.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 54.0, 57.0, 55.0, 56.0, 55.0, 54.0, 54.0, 55.0, 56.0], "value": 55.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 73.0, 72.0, 71.0, 73.0, 72.0, 86.0, 73.0, 72.0, 73.0], "value": 74.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [128.0, 122.0, 112.0, 112.0, 118.0, 112.0, 131.0, 112.0, 112.0, 160.0], "value": 121.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 167.0, 160.0, 162.0, 162.0, 161.0, 162.0, 166.0, 163.0, 160.0], "value": 163.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 63.0, 65.0, 61.0, 61.0, 63.0, 62.0, 62.0, 62.0, 67.0], "value": 62.8, "unit": "score"}]}]} 11:42:04 INFO - Return code: 0 11:42:04 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:42:04 INFO - # TBPL SUCCESS # 11:42:04 INFO - Running post-action listener: _package_coverage_data 11:42:04 INFO - Running post-action listener: _resource_record_post_action 11:42:04 INFO - [mozharness: 2017-08-21 18:42:04.657810Z] Finished run-tests step (success) 11:42:04 INFO - Running post-run listener: _resource_record_post_run 11:42:04 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 6451200; Write bytes: 437985280; Read time: 2900; Write time: 292964 11:42:04 INFO - TinderboxPrint: CPU usage
13.1% 11:42:04 INFO - TinderboxPrint: I/O read bytes / time
6,451,200 / 2,900 11:42:04 INFO - TinderboxPrint: I/O write bytes / time
437,985,280 / 292,964 11:42:04 INFO - TinderboxPrint: CPU idle
8,253.4 (86.9%) 11:42:04 INFO - TinderboxPrint: CPU user
1,189.2 (12.5%) 11:42:04 INFO - TinderboxPrint: Swap in / out
0 / 0 11:42:04 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 4096; Write bytes: 115380224; Read time: 48; Write time: 74376 11:42:04 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 11:42:04 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 4075520; Write bytes: 322605056; Read time: 2340; Write time: 218588 11:42:05 INFO - Running post-run listener: _upload_blobber_files 11:42:05 INFO - Blob upload gear active. 11:42:05 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:42:05 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:42:05 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:42:05 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:42:05 INFO - (blobuploader) - INFO - Open directory for files ... 11:42:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 11:42:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:42:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:42:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 11:42:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:42:06 INFO - (blobuploader) - INFO - Done attempting. 11:42:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:42:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:42:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:42:13 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:42:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:42:13 INFO - (blobuploader) - INFO - Done attempting. 11:42:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 11:42:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:42:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:42:13 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 11:42:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:42:13 INFO - (blobuploader) - INFO - Done attempting. 11:42:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 11:42:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:42:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:42:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 11:42:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:42:14 INFO - (blobuploader) - INFO - Done attempting. 11:42:14 INFO - (blobuploader) - INFO - Iteration through files over. 11:42:14 INFO - Return code: 0 11:42:14 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:42:14 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:42:14 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b2f98815765bb9e0427cbe11e388c5ab9cb7628cffd8d03bdfce81807c7c77a6b18aa66bab8844e5b7b3e9dd8ceb3053f3e6a3b9e50b0fb8a35a15b972ab0a59", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1f8c388608e97dff13b46fbc296f9d8dd15033347b1bf87fb82b6dc53c0730470f1c5a4819e06e702338d1016c8a67212bf8403650da0ecffcd69c71c9f8533d", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bc5926aaa1f42e8914c5556cfce4d801dbf0c14fc80aa9cbdd92d35b739e48744d86c8b6c26cfa3c2f1061770f557e1c5b9a627dc943a1132dc94b2b383048f3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5a5033b7afa8fc1516cb2c954799f65edf68d69f55824e6c4d53fc437e3a9a38429bc7a6b7e41792ab251b7cb6ace3e67d91362052d0ddb5da82f0496d76ef54"} 11:42:14 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:42:14 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:42:14 INFO - Contents: 11:42:14 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b2f98815765bb9e0427cbe11e388c5ab9cb7628cffd8d03bdfce81807c7c77a6b18aa66bab8844e5b7b3e9dd8ceb3053f3e6a3b9e50b0fb8a35a15b972ab0a59", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1f8c388608e97dff13b46fbc296f9d8dd15033347b1bf87fb82b6dc53c0730470f1c5a4819e06e702338d1016c8a67212bf8403650da0ecffcd69c71c9f8533d", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bc5926aaa1f42e8914c5556cfce4d801dbf0c14fc80aa9cbdd92d35b739e48744d86c8b6c26cfa3c2f1061770f557e1c5b9a627dc943a1132dc94b2b383048f3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5a5033b7afa8fc1516cb2c954799f65edf68d69f55824e6c4d53fc437e3a9a38429bc7a6b7e41792ab251b7cb6ace3e67d91362052d0ddb5da82f0496d76ef54"} 11:42:14 INFO - Running post-run listener: copy_logs_to_upload_dir 11:42:14 INFO - Copying logs to upload dir... 11:42:14 INFO - mkdir: /builds/slave/test/build/upload/logs 11:42:14 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1256.483365 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2017-08-21 11:42:14.746975) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-21 11:42:14.751958) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1503338607.495298-417619000 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b2f98815765bb9e0427cbe11e388c5ab9cb7628cffd8d03bdfce81807c7c77a6b18aa66bab8844e5b7b3e9dd8ceb3053f3e6a3b9e50b0fb8a35a15b972ab0a59", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1f8c388608e97dff13b46fbc296f9d8dd15033347b1bf87fb82b6dc53c0730470f1c5a4819e06e702338d1016c8a67212bf8403650da0ecffcd69c71c9f8533d", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bc5926aaa1f42e8914c5556cfce4d801dbf0c14fc80aa9cbdd92d35b739e48744d86c8b6c26cfa3c2f1061770f557e1c5b9a627dc943a1132dc94b2b383048f3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5a5033b7afa8fc1516cb2c954799f65edf68d69f55824e6c4d53fc437e3a9a38429bc7a6b7e41792ab251b7cb6ace3e67d91362052d0ddb5da82f0496d76ef54"} build_url:https://queue.taskcluster.net/v1/task/dgb5MIIuQw2LKtY8dH2Fjg/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011337 build_url: 'https://queue.taskcluster.net/v1/task/dgb5MIIuQw2LKtY8dH2Fjg/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b2f98815765bb9e0427cbe11e388c5ab9cb7628cffd8d03bdfce81807c7c77a6b18aa66bab8844e5b7b3e9dd8ceb3053f3e6a3b9e50b0fb8a35a15b972ab0a59", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1f8c388608e97dff13b46fbc296f9d8dd15033347b1bf87fb82b6dc53c0730470f1c5a4819e06e702338d1016c8a67212bf8403650da0ecffcd69c71c9f8533d", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bc5926aaa1f42e8914c5556cfce4d801dbf0c14fc80aa9cbdd92d35b739e48744d86c8b6c26cfa3c2f1061770f557e1c5b9a627dc943a1132dc94b2b383048f3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5a5033b7afa8fc1516cb2c954799f65edf68d69f55824e6c4d53fc437e3a9a38429bc7a6b7e41792ab251b7cb6ace3e67d91362052d0ddb5da82f0496d76ef54"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-21 11:42:14.778358) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-21 11:42:14.778683) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1503338607.495298-417619000 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004539 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-21 11:42:14.863481) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-21 11:42:14.863797) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-21 11:42:14.864089) ========= ========= Total master_lag: 0.20 =========