builder: mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s slave: talos-linux64-ix-006 starttime: 1504863502.76 results: success (0) revision: dd75dcec7da162d8ceaaf0883e0e7561bd772992 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-08 02:38:22.761648) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-08 02:38:22.762065) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-08 02:38:22.762415) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-08 02:38:22.784035) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-08 02:38:22.784422) ========= 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-1504863418.753420-1283253239 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-08 02:38:22-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.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% 46.3M=0s 2017-09-08 02:38:22 (46.3 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.123737 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-08 02:38:22.925487) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-08 02:38:22.925820) ========= 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-1504863418.753420-1283253239 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.013995 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-08 02:38:22.975794) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-08 02:38:22.976129) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev dd75dcec7da162d8ceaaf0883e0e7561bd772992 --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 dd75dcec7da162d8ceaaf0883e0e7561bd772992 --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-1504863418.753420-1283253239 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-08 02:38:23,027 truncating revision to first 12 chars 2017-09-08 02:38:23,027 Setting DEBUG logging. 2017-09-08 02:38:23,027 attempt 1/10 2017-09-08 02:38:23,028 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/dd75dcec7da1?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-08 02:38:23,299 unpacking tar archive at: mozilla-central-dd75dcec7da1/testing/mozharness/ program finished with exit code 0 elapsedTime=0.632060 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-08 02:38:23.624529) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-08 02:38:23.624843) ========= script_repo_revision: dd75dcec7da162d8ceaaf0883e0e7561bd772992 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-08 02:38:23.625242) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-08 02:38:23.625512) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-08 02:38:23.637960) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2017-09-08 02:38:23.638343) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-stylo-disabled-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 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-stylo-disabled-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] 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-1504863418.753420-1283253239 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:38:23 INFO - MultiFileLogger online at 20170908 02:38:23 in /builds/slave/test 02:38:23 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-stylo-disabled-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 02:38:23 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:38:23 INFO - {'append_to_log': False, 02:38:23 INFO - 'base_work_dir': '/builds/slave/test', 02:38:23 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 02:38:23 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:38:23 INFO - 'branch': 'Firefox-Non-PGO', 02:38:23 INFO - 'buildbot_json_path': 'buildprops.json', 02:38:23 INFO - 'code_coverage': False, 02:38:23 INFO - 'config_files': ('talos/linux_config.py',), 02:38:23 INFO - 'default_actions': ('clobber', 02:38:23 INFO - 'read-buildbot-config', 02:38:23 INFO - 'download-and-extract', 02:38:23 INFO - 'populate-webroot', 02:38:23 INFO - 'create-virtualenv', 02:38:23 INFO - 'install', 02:38:23 INFO - 'setup-mitmproxy', 02:38:23 INFO - 'run-tests'), 02:38:23 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:38:23 INFO - 'disable_ccov_upload': False, 02:38:23 INFO - 'disable_stylo': False, 02:38:23 INFO - 'download_minidump_stackwalk': True, 02:38:23 INFO - 'download_symbols': 'ondemand', 02:38:23 INFO - 'enable_stylo': False, 02:38:23 INFO - 'enable_webrender': False, 02:38:23 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 02:38:23 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:38:23 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:38:23 INFO - 'gecko_profile': False, 02:38:23 INFO - 'gecko_profile_interval': 0, 02:38:23 INFO - 'installer_path': 'installer.exe', 02:38:23 INFO - 'log_level': 'info', 02:38:23 INFO - 'log_name': 'talos', 02:38:23 INFO - 'log_to_console': True, 02:38:23 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:38:23 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:38:23 INFO - 'opt_config_files': (), 02:38:23 INFO - 'pip_index': False, 02:38:23 INFO - 'suite': 'dromaeojs-stylo-disabled-e10s', 02:38:23 INFO - 'system_bits': '32', 02:38:23 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:38:23 INFO - 'title': 'talos-linux64-ix-006', 02:38:23 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:38:23 INFO - 'use_talos_json': True, 02:38:23 INFO - 'verify': 'False', 02:38:23 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:38:23 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:38:23 INFO - 'work_dir': 'build'} 02:38:23 INFO - [mozharness: 2017-09-08 09:38:23.835123Z] Running clobber step. 02:38:23 INFO - Running pre-action listener: _resource_record_pre_action 02:38:23 INFO - Running main action method: clobber 02:38:23 INFO - rmtree: /builds/slave/test/build 02:38:23 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:38:24 INFO - Running post-action listener: _resource_record_post_action 02:38:24 INFO - [mozharness: 2017-09-08 09:38:24.850783Z] Finished clobber step (success) 02:38:24 INFO - [mozharness: 2017-09-08 09:38:24.850881Z] Running read-buildbot-config step. 02:38:24 INFO - Running pre-action listener: _resource_record_pre_action 02:38:24 INFO - Running main action method: read_buildbot_config 02:38:24 INFO - Using buildbot properties: 02:38:24 INFO - { 02:38:24 INFO - "project": "", 02:38:24 INFO - "product": "firefox", 02:38:24 INFO - "who": "archaeopteryx@coole-files.de", 02:38:24 INFO - "installer_path": "public/build/target.tar.bz2", 02:38:24 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s", 02:38:24 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 02:38:24 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-stylo-disabled-e10s", 02:38:24 INFO - "stage_platform": "linux64", 02:38:24 INFO - "basedir": "/builds/slave/test", 02:38:24 INFO - "buildnumber": 1, 02:38:24 INFO - "platform": "ubuntu64_hw", 02:38:24 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 02:38:24 INFO - "slavebuilddir": "test", 02:38:24 INFO - "taskId": "ZH-L60s6St2-d7H2Awbbzg", 02:38:24 INFO - "branch": "mozilla-central", 02:38:24 INFO - "script_repo_revision": "production", 02:38:24 INFO - "revision": "dd75dcec7da162d8ceaaf0883e0e7561bd772992", 02:38:24 INFO - "slavename": "talos-linux64-ix-006", 02:38:24 INFO - "repo_path": "mozilla-central" 02:38:24 INFO - } 02:38:24 INFO - Finding installer, test and symbols from parent task. 02:38:24 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZH-L60s6St2-d7H2Awbbzg'}, attempt #1 02:38:25 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZH-L60s6St2-d7H2Awbbzg'}, attempt #1 02:38:25 INFO - Task dependencies: bhya0MgVT7S5tIHCfYUKiw 02:38:25 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bhya0MgVT7S5tIHCfYUKiw'}, attempt #1 02:38:26 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/bhya0MgVT7S5tIHCfYUKiw/artifacts/public/build/target.tar.bz2 02:38:26 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/bhya0MgVT7S5tIHCfYUKiw/artifacts/public/build/target.test_packages.json 02:38:26 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/bhya0MgVT7S5tIHCfYUKiw/artifacts/public/build/target.crashreporter-symbols.zip 02:38:26 INFO - Running post-action listener: _resource_record_post_action 02:38:26 INFO - [mozharness: 2017-09-08 09:38:26.254838Z] Finished read-buildbot-config step (success) 02:38:26 INFO - [mozharness: 2017-09-08 09:38:26.255054Z] Running download-and-extract step. 02:38:26 INFO - Running pre-action listener: _resource_record_pre_action 02:38:26 INFO - Running main action method: download_and_extract 02:38:26 INFO - mkdir: /builds/slave/test/build/tests 02:38:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:38:26 INFO - trying https://queue.taskcluster.net/v1/task/bhya0MgVT7S5tIHCfYUKiw/artifacts/public/build/target.test_packages.json 02:38:26 INFO - Downloading https://queue.taskcluster.net/v1/task/bhya0MgVT7S5tIHCfYUKiw/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 02:38:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bhya0MgVT7S5tIHCfYUKiw/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 02:38:26 INFO - Downloaded 989 bytes. 02:38:26 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 02:38:26 INFO - Using the following test package requirements: 02:38:26 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 02:38:26 INFO - u'common': [u'target.common.tests.zip'], 02:38:26 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 02:38:26 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 02:38:26 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 02:38:26 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 02:38:26 INFO - u'mozbase': [u'target.common.tests.zip'], 02:38:26 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 02:38:26 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 02:38:26 INFO - u'web-platform': [u'target.common.tests.zip', 02:38:26 INFO - u'target.web-platform.tests.tar.gz'], 02:38:26 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 02:38:26 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 02:38:26 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/bhya0MgVT7S5tIHCfYUKiw/artifacts/public/build/target.common.tests.zip 02:38:26 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bhya0MgVT7S5tIHCfYUKiw/artifacts/public/build/target.common.tests.zip'}, attempt #1 02:38:26 INFO - Fetch https://queue.taskcluster.net/v1/task/bhya0MgVT7S5tIHCfYUKiw/artifacts/public/build/target.common.tests.zip into memory 02:38:30 INFO - Content-Length response header: 55023700 02:38:30 INFO - Bytes received: 55023700 02:38:41 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 02:38:41 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/bhya0MgVT7S5tIHCfYUKiw/artifacts/public/build/target.common.tests.zip 02:38:41 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bhya0MgVT7S5tIHCfYUKiw/artifacts/public/build/target.common.tests.zip'}, attempt #1 02:38:41 INFO - Fetch https://queue.taskcluster.net/v1/task/bhya0MgVT7S5tIHCfYUKiw/artifacts/public/build/target.common.tests.zip into memory 02:38:43 INFO - Content-Length response header: 55023700 02:38:43 INFO - Bytes received: 55023700 02:38:56 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/bhya0MgVT7S5tIHCfYUKiw/artifacts/public/build/target.talos.tests.zip 02:38:56 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bhya0MgVT7S5tIHCfYUKiw/artifacts/public/build/target.talos.tests.zip'}, attempt #1 02:38:56 INFO - Fetch https://queue.taskcluster.net/v1/task/bhya0MgVT7S5tIHCfYUKiw/artifacts/public/build/target.talos.tests.zip into memory 02:38:57 INFO - Content-Length response header: 14496665 02:38:57 INFO - Bytes received: 14496665 02:38: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')]} 02:38:57 INFO - trying https://queue.taskcluster.net/v1/task/bhya0MgVT7S5tIHCfYUKiw/artifacts/public/build/target.tar.bz2 02:38:57 INFO - Downloading https://queue.taskcluster.net/v1/task/bhya0MgVT7S5tIHCfYUKiw/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 02:38:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bhya0MgVT7S5tIHCfYUKiw/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 02:38:58 INFO - Downloaded 62722712 bytes. 02:38:58 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/bhya0MgVT7S5tIHCfYUKiw/artifacts/public/build/target.tar.bz2 02:38:58 INFO - mkdir: /builds/slave/test/properties 02:38:58 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:38:58 INFO - Writing to file /builds/slave/test/properties/build_url 02:38:58 INFO - Contents: 02:38:58 INFO - build_url:https://queue.taskcluster.net/v1/task/bhya0MgVT7S5tIHCfYUKiw/artifacts/public/build/target.tar.bz2 02:38:58 INFO - Running post-action listener: _resource_record_post_action 02:38:58 INFO - Running post-action listener: find_tests_for_verification 02:38:58 INFO - Running post-action listener: set_extra_try_arguments 02:38:58 INFO - [mozharness: 2017-09-08 09:38:58.910862Z] Finished download-and-extract step (success) 02:38:58 INFO - [mozharness: 2017-09-08 09:38:58.910959Z] Running populate-webroot step. 02:38:58 INFO - Running pre-action listener: _resource_record_pre_action 02:38:58 INFO - Running main action method: populate_webroot 02:38:58 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:38:58 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 02:38:58 INFO - 'tests': ['tresize', 02:38:58 INFO - 'tcanvasmark']}, 02:38:58 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:38:58 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 02:38:58 INFO - 'tests': ['dromaeo_css', 02:38:58 INFO - 'kraken']}, 02:38:58 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 02:38:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:38:58 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 02:38:58 INFO - 'talos_options': ['--disable-stylo'], 02:38:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:38:58 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 02:38:58 INFO - 'tests': ['damp', 'tps']}, 02:38:58 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 02:38:58 INFO - 'talos_options': ['--disable-stylo'], 02:38:58 INFO - 'tests': ['damp', 'tps']}, 02:38:58 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:38:58 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 02:38:58 INFO - 'tests': ['dromaeo_dom']}, 02:38:58 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 02:38:58 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 02:38:58 INFO - 'tests': ['basic_compositor_video', 02:38:58 INFO - 'glvideo']}, 02:38:58 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 02:38:58 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 02:38:58 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 02:38:58 INFO - 'talos_options': ['--disable-stylo'], 02:38:58 INFO - 'tests': ['ts_paint_webext', 02:38:58 INFO - 'tp5o_webext']}, 02:38:58 INFO - 'other-e10s': {'tests': ['a11yr', 02:38:58 INFO - 'ts_paint', 02:38:58 INFO - 'tpaint', 02:38:58 INFO - 'sessionrestore', 02:38:58 INFO - 'sessionrestore_many_windows', 02:38:58 INFO - 'sessionrestore_no_auto_restore', 02:38:58 INFO - 'tabpaint']}, 02:38:58 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 02:38:58 INFO - 'tests': ['a11yr', 02:38:58 INFO - 'ts_paint', 02:38:58 INFO - 'tpaint', 02:38:58 INFO - 'sessionrestore', 02:38:58 INFO - 'sessionrestore_many_windows', 02:38:58 INFO - 'sessionrestore_no_auto_restore', 02:38:58 INFO - 'tabpaint']}, 02:38:58 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 02:38:58 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 02:38:58 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 02:38:58 INFO - 'tests': ['bloom_basic_singleton']}, 02:38:58 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 02:38:58 INFO - 'tests': ['bloom_basic']}, 02:38:58 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:38:58 INFO - 'tsvgr_opacity', 02:38:58 INFO - 'tart', 02:38:58 INFO - 'tscrollx', 02:38:58 INFO - 'tsvg_static']}, 02:38:58 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 02:38:58 INFO - 'tests': ['tsvgx', 02:38:58 INFO - 'tsvgr_opacity', 02:38:58 INFO - 'tart', 02:38:58 INFO - 'tscrollx', 02:38:58 INFO - 'tsvg_static']}, 02:38:58 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 02:38:58 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 02:38:58 INFO - 'talos_options': ['--disable-stylo'], 02:38:58 INFO - 'tests': ['tp5o']}, 02:38:58 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 02:38:58 INFO - 'talos_options': ['--mitmproxy', 02:38:58 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 02:38:58 INFO - '--firstNonBlankPaint'], 02:38:58 INFO - 'tests': ['tp6_google', 02:38:58 INFO - 'tp6_youtube', 02:38:58 INFO - 'tp6_amazon', 02:38:58 INFO - 'tp6_facebook']}, 02:38:58 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 02:38:58 INFO - 'talos_options': ['--disable-stylo', 02:38:58 INFO - '--mitmproxy', 02:38:58 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 02:38:58 INFO - '--firstNonBlankPaint'], 02:38:58 INFO - 'tests': ['tp6_google', 02:38:58 INFO - 'tp6_youtube', 02:38:58 INFO - 'tp6_amazon', 02:38:58 INFO - 'tp6_facebook']}, 02:38:58 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 02:38:58 INFO - 'talos_options': ['--stylo-threads=1', 02:38:58 INFO - '--mitmproxy', 02:38:58 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 02:38:58 INFO - '--firstNonBlankPaint'], 02:38:58 INFO - 'tests': ['tp6_google', 02:38:58 INFO - 'tp6_youtube', 02:38:58 INFO - 'tp6_amazon', 02:38:58 INFO - 'tp6_facebook']}, 02:38:58 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 02:38:58 INFO - 'talos_options': ['--xperf_path', 02:38:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:38:58 INFO - 'tests': ['tp5n']}, 02:38:58 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 02:38:58 INFO - 'talos_options': ['--disable-stylo', 02:38:58 INFO - '--xperf_path', 02:38:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:38:58 INFO - 'tests': ['tp5n']}}} 02:38:58 INFO - Running post-action listener: _resource_record_post_action 02:38:58 INFO - [mozharness: 2017-09-08 09:38:58.926020Z] Finished populate-webroot step (success) 02:38:58 INFO - [mozharness: 2017-09-08 09:38:58.926110Z] Running create-virtualenv step. 02:38:58 INFO - Running pre-action listener: _resource_record_pre_action 02:38:58 INFO - Running main action method: create_virtualenv 02:38:58 INFO - Creating virtualenv /builds/slave/test/build/venv 02:38:58 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 02:38:58 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 02:38:58 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 02:38:59 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:38:59 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:38:59 INFO - Installing distribute.............................................................................................................................................................................................done. 02:38:59 INFO - Installing pip...............done. 02:38:59 INFO - Return code: 0 02:38:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 02:38:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 02:38:59 INFO - Reading from file tmpfile_stdout 02:38:59 INFO - Output received: 02:38:59 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 02:38:59 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:38: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')]} 02:38:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:38: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')]} 02:38:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:38: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ab91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c82a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e25a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e29090>, '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 0x1e29d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e23f90>, '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-1504863418.753420-1283253239', '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 02:38: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', 'pip>=1.5'] in /builds/slave/test/build 02:38: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 pip>=1.5 02:38:59 INFO - Using env: {'DISPLAY': ':0', 02:38:59 INFO - 'HOME': '/home/cltbld', 02:38:59 INFO - 'LANG': 'en_US.UTF-8', 02:38:59 INFO - 'LANGUAGE': 'en_US:en', 02:38:59 INFO - 'LOGNAME': 'cltbld', 02:38:59 INFO - 'MAIL': '/var/mail/cltbld', 02:38:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:38:59 INFO - 'MOZ_NO_REMOTE': '1', 02:38:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:38:59 INFO - 'NO_EM_RESTART': '1', 02:38:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:38:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:38:59 INFO - 'PWD': '/builds/slave/test', 02:38:59 INFO - 'SHELL': '/bin/bash', 02:38:59 INFO - 'SHLVL': '1', 02:38:59 INFO - 'TERM': 'linux', 02:38:59 INFO - 'TMOUT': '86400', 02:38:59 INFO - 'USER': 'cltbld', 02:38:59 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1504863418.753420-1283253239', 02:38:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:38:59 INFO - '_': '/tools/buildbot/bin/python'} 02:39:01 INFO - Ignoring indexes: http://pypi.python.org/simple/ 02:39:01 INFO - Downloading/unpacking pip>=1.5 02:39:01 INFO - Running setup.py egg_info for package pip 02:39:01 INFO - warning: no files found matching 'pip/cacert.pem' 02:39:01 INFO - warning: no files found matching '*.html' under directory 'docs' 02:39:01 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 02:39:01 INFO - no previously-included directories found matching 'docs/_build/_sources' 02:39:01 INFO - Installing collected packages: pip 02:39:01 INFO - Found existing installation: pip 1.1 02:39:01 INFO - Uninstalling pip: 02:39:01 INFO - Successfully uninstalled pip 02:39:01 INFO - Running setup.py install for pip 02:39:01 INFO - warning: no files found matching 'pip/cacert.pem' 02:39:01 INFO - warning: no files found matching '*.html' under directory 'docs' 02:39:01 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 02:39:01 INFO - no previously-included directories found matching 'docs/_build/_sources' 02:39:01 INFO - Installing pip script to /builds/slave/test/build/venv/bin 02:39:01 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 02:39:01 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 02:39:01 INFO - Successfully installed pip 02:39:01 INFO - Cleaning up... 02:39:01 INFO - Return code: 0 02:39:01 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:39: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')]} 02:39:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:39: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')]} 02:39:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:39: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', '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 0x1ab91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c82a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e25a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e29090>, '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 0x1e29d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e23f90>, '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-1504863418.753420-1283253239', '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 02:39: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', 'psutil>=3.1.1'] in /builds/slave/test/build 02:39: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 psutil>=3.1.1 02:39:01 INFO - Using env: {'DISPLAY': ':0', 02:39:01 INFO - 'HOME': '/home/cltbld', 02:39:01 INFO - 'LANG': 'en_US.UTF-8', 02:39:01 INFO - 'LANGUAGE': 'en_US:en', 02:39:01 INFO - 'LOGNAME': 'cltbld', 02:39:01 INFO - 'MAIL': '/var/mail/cltbld', 02:39:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:39:01 INFO - 'MOZ_NO_REMOTE': '1', 02:39:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:39:01 INFO - 'NO_EM_RESTART': '1', 02:39:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:39:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:39:01 INFO - 'PWD': '/builds/slave/test', 02:39:01 INFO - 'SHELL': '/bin/bash', 02:39:01 INFO - 'SHLVL': '1', 02:39:01 INFO - 'TERM': 'linux', 02:39:01 INFO - 'TMOUT': '86400', 02:39:01 INFO - 'USER': 'cltbld', 02:39:01 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1504863418.753420-1283253239', 02:39:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:39:01 INFO - '_': '/tools/buildbot/bin/python'} 02:39:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:39:01 INFO - Downloading/unpacking psutil>=3.1.1 02:39: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 02:39: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 02:39: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 02:39: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 02:39:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:39:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:39:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:39:02 INFO - Installing collected packages: psutil 02:39:02 INFO - Running setup.py install for psutil 02:39:02 INFO - building 'psutil._psutil_linux' extension 02:39:02 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 02:39:02 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 02:39:02 INFO - building 'psutil._psutil_posix' extension 02:39:02 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 02:39:02 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 02:39:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:39:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:39:03 INFO - Successfully installed psutil 02:39:03 INFO - Cleaning up... 02:39:03 INFO - Return code: 0 02:39:03 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:39: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')]} 02:39:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:39: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')]} 02:39:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:39:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ab91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c82a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e25a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e29090>, '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 0x1e29d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e23f90>, '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-1504863418.753420-1283253239', '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 02:39:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 02:39:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 02:39:03 INFO - Using env: {'DISPLAY': ':0', 02:39:03 INFO - 'HOME': '/home/cltbld', 02:39:03 INFO - 'LANG': 'en_US.UTF-8', 02:39:03 INFO - 'LANGUAGE': 'en_US:en', 02:39:03 INFO - 'LOGNAME': 'cltbld', 02:39:03 INFO - 'MAIL': '/var/mail/cltbld', 02:39:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:39:03 INFO - 'MOZ_NO_REMOTE': '1', 02:39:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:39:03 INFO - 'NO_EM_RESTART': '1', 02:39:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:39:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:39:03 INFO - 'PWD': '/builds/slave/test', 02:39:03 INFO - 'SHELL': '/bin/bash', 02:39:03 INFO - 'SHLVL': '1', 02:39:03 INFO - 'TERM': 'linux', 02:39:03 INFO - 'TMOUT': '86400', 02:39:03 INFO - 'USER': 'cltbld', 02:39:03 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1504863418.753420-1283253239', 02:39:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:39:03 INFO - '_': '/tools/buildbot/bin/python'} 02:39:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:39:03 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:39: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 02:39: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 02:39: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 02:39: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 02:39:04 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:39:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:39:04 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:39:04 INFO - Installing collected packages: mozsystemmonitor 02:39:04 INFO - Running setup.py install for mozsystemmonitor 02:39:04 INFO - Successfully installed mozsystemmonitor 02:39:04 INFO - Cleaning up... 02:39:04 INFO - Return code: 0 02:39:04 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:39:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:39:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:39:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:39:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:39:04 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 0x1ab91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c82a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e25a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e29090>, '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 0x1e29d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e23f90>, '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-1504863418.753420-1283253239', '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 02:39:04 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 02:39:04 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 02:39:04 INFO - Using env: {'DISPLAY': ':0', 02:39:04 INFO - 'HOME': '/home/cltbld', 02:39:04 INFO - 'LANG': 'en_US.UTF-8', 02:39:04 INFO - 'LANGUAGE': 'en_US:en', 02:39:04 INFO - 'LOGNAME': 'cltbld', 02:39:04 INFO - 'MAIL': '/var/mail/cltbld', 02:39:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:39:04 INFO - 'MOZ_NO_REMOTE': '1', 02:39:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:39:04 INFO - 'NO_EM_RESTART': '1', 02:39:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:39:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:39:04 INFO - 'PWD': '/builds/slave/test', 02:39:04 INFO - 'SHELL': '/bin/bash', 02:39:04 INFO - 'SHLVL': '1', 02:39:04 INFO - 'TERM': 'linux', 02:39:04 INFO - 'TMOUT': '86400', 02:39:04 INFO - 'USER': 'cltbld', 02:39:04 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1504863418.753420-1283253239', 02:39:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:39:04 INFO - '_': '/tools/buildbot/bin/python'} 02:39:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:39:04 INFO - Downloading/unpacking jsonschema==2.5.1 02:39:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:39:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:39:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:39:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:39:05 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:39:05 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:39:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:39:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:39:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:39:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:39:05 INFO - Downloading functools32-3.2.3-2.tar.gz 02:39:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:39:06 INFO - warning: no files found matching '*.txt' 02:39:06 INFO - no previously-included directories found matching 'build' 02:39:06 INFO - no previously-included directories found matching 'dist' 02:39:06 INFO - no previously-included directories found matching '.git*' 02:39:06 INFO - Installing collected packages: jsonschema, functools32 02:39:06 INFO - Running setup.py install for functools32 02:39:06 INFO - warning: no files found matching '*.txt' 02:39:06 INFO - no previously-included directories found matching 'build' 02:39:06 INFO - no previously-included directories found matching 'dist' 02:39:06 INFO - no previously-included directories found matching '.git*' 02:39:06 INFO - Successfully installed jsonschema functools32 02:39:06 INFO - Cleaning up... 02:39:06 INFO - Return code: 0 02:39:06 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 02:39:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:39:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:39:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:39:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:39:06 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 0x1ab91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c82a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e25a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e29090>, '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 0x1e29d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e23f90>, '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-1504863418.753420-1283253239', '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 02:39:06 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 02:39:06 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 02:39:06 INFO - Using env: {'DISPLAY': ':0', 02:39:06 INFO - 'HOME': '/home/cltbld', 02:39:06 INFO - 'LANG': 'en_US.UTF-8', 02:39:06 INFO - 'LANGUAGE': 'en_US:en', 02:39:06 INFO - 'LOGNAME': 'cltbld', 02:39:06 INFO - 'MAIL': '/var/mail/cltbld', 02:39:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:39:06 INFO - 'MOZ_NO_REMOTE': '1', 02:39:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:39:06 INFO - 'NO_EM_RESTART': '1', 02:39:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:39:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:39:06 INFO - 'PWD': '/builds/slave/test', 02:39:06 INFO - 'SHELL': '/bin/bash', 02:39:06 INFO - 'SHLVL': '1', 02:39:06 INFO - 'TERM': 'linux', 02:39:06 INFO - 'TMOUT': '86400', 02:39:06 INFO - 'USER': 'cltbld', 02:39:06 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1504863418.753420-1283253239', 02:39:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:39:06 INFO - '_': '/tools/buildbot/bin/python'} 02:39:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:39:06 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 02:39:06 INFO - Cleaning up... 02:39:06 INFO - Return code: 0 02:39:06 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:39:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:39:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:39:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:39:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:39:06 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 0x1ab91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c82a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e25a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e29090>, '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 0x1e29d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e23f90>, '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-1504863418.753420-1283253239', '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 02:39:06 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 02:39:06 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 02:39:06 INFO - Using env: {'DISPLAY': ':0', 02:39:06 INFO - 'HOME': '/home/cltbld', 02:39:06 INFO - 'LANG': 'en_US.UTF-8', 02:39:06 INFO - 'LANGUAGE': 'en_US:en', 02:39:06 INFO - 'LOGNAME': 'cltbld', 02:39:06 INFO - 'MAIL': '/var/mail/cltbld', 02:39:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:39:06 INFO - 'MOZ_NO_REMOTE': '1', 02:39:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:39:06 INFO - 'NO_EM_RESTART': '1', 02:39:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:39:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:39:06 INFO - 'PWD': '/builds/slave/test', 02:39:06 INFO - 'SHELL': '/bin/bash', 02:39:06 INFO - 'SHLVL': '1', 02:39:06 INFO - 'TERM': 'linux', 02:39:06 INFO - 'TMOUT': '86400', 02:39:06 INFO - 'USER': 'cltbld', 02:39:06 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1504863418.753420-1283253239', 02:39:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:39:06 INFO - '_': '/tools/buildbot/bin/python'} 02:39:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:39:06 INFO - Downloading/unpacking blobuploader==1.2.4 02:39:06 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 02:39:06 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 02:39:06 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 02:39:06 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 02:39:07 INFO - Downloading blobuploader-1.2.4.tar.gz 02:39:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:39:07 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:39:07 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 02:39:07 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 02:39:07 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 02:39:07 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 02:39:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:39:08 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:39: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 02:39: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 02:39: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 02:39: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 02:39:08 INFO - Downloading docopt-0.6.1.tar.gz 02:39:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:39:08 INFO - Installing collected packages: blobuploader, requests, docopt 02:39:08 INFO - Running setup.py install for blobuploader 02:39:08 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:39:08 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:39:08 INFO - Running setup.py install for requests 02:39:08 INFO - Running setup.py install for docopt 02:39:08 INFO - Successfully installed blobuploader requests docopt 02:39:08 INFO - Cleaning up... 02:39:08 INFO - Return code: 0 02:39:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:39:08 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')]} 02:39:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:39:08 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')]} 02:39:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:39:08 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 0x1ab91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c82a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e25a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e29090>, '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 0x1e29d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e23f90>, '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-1504863418.753420-1283253239', '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 02:39:08 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 02:39:08 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 02:39:08 INFO - Using env: {'DISPLAY': ':0', 02:39:08 INFO - 'HOME': '/home/cltbld', 02:39:08 INFO - 'LANG': 'en_US.UTF-8', 02:39:08 INFO - 'LANGUAGE': 'en_US:en', 02:39:08 INFO - 'LOGNAME': 'cltbld', 02:39:08 INFO - 'MAIL': '/var/mail/cltbld', 02:39:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:39:08 INFO - 'MOZ_NO_REMOTE': '1', 02:39:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:39:08 INFO - 'NO_EM_RESTART': '1', 02:39:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:39:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:39:08 INFO - 'PWD': '/builds/slave/test', 02:39:08 INFO - 'SHELL': '/bin/bash', 02:39:08 INFO - 'SHLVL': '1', 02:39:08 INFO - 'TERM': 'linux', 02:39:08 INFO - 'TMOUT': '86400', 02:39:08 INFO - 'USER': 'cltbld', 02:39:08 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1504863418.753420-1283253239', 02:39:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:39:08 INFO - '_': '/tools/buildbot/bin/python'} 02:39:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:39:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:39:09 INFO - Running setup.py (path:/tmp/pip-1vosHA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:39:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:39:09 INFO - Running setup.py (path:/tmp/pip-pgFnU3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:39:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:39:09 INFO - Running setup.py (path:/tmp/pip-dyrsBj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:39:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:39:09 INFO - Running setup.py (path:/tmp/pip-pM11Z3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:39:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:39:09 INFO - Running setup.py (path:/tmp/pip-xulcWA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:39:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:39:09 INFO - Running setup.py (path:/tmp/pip-47MV7P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:39:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:39:09 INFO - Running setup.py (path:/tmp/pip-tZt2g5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:39:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:39:09 INFO - Running setup.py (path:/tmp/pip-IJrcG9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:39:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:39:09 INFO - Running setup.py (path:/tmp/pip-n9aRXW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:39:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:39:09 INFO - Running setup.py (path:/tmp/pip-2XpRCC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:39:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:39:09 INFO - Running setup.py (path:/tmp/pip-3o85He-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:39:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:39:09 INFO - Running setup.py (path:/tmp/pip-Bl3aFK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:39:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:39:09 INFO - Running setup.py (path:/tmp/pip-IBqkGR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:39:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:39:10 INFO - Running setup.py (path:/tmp/pip-91XY_8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:39:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:39:10 INFO - Running setup.py (path:/tmp/pip-ndPowT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:39:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:39:10 INFO - Running setup.py (path:/tmp/pip-6tlBJ_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:39:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:39:10 INFO - Running setup.py (path:/tmp/pip-AraakD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:39:10 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:39:10 INFO - Running setup.py install for manifestparser 02:39:10 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:39:10 INFO - Running setup.py install for mozcrash 02:39:10 INFO - Running setup.py install for mozdebug 02:39:10 INFO - Running setup.py install for mozdevice 02:39:10 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:39:10 INFO - Running setup.py install for mozfile 02:39:10 INFO - Running setup.py install for mozhttpd 02:39:10 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:39:10 INFO - Running setup.py install for mozinfo 02:39:11 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:39:11 INFO - Running setup.py install for mozInstall 02:39:11 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:39:11 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:39:11 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:39:11 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:39:11 INFO - Running setup.py install for mozleak 02:39:11 INFO - Running setup.py install for mozlog 02:39:11 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:39:11 INFO - Running setup.py install for moznetwork 02:39:11 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:39:11 INFO - Running setup.py install for mozprocess 02:39:11 INFO - Running setup.py install for mozprofile 02:39:11 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:39:11 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:39:11 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:39:11 INFO - Running setup.py install for mozrunner 02:39:11 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:39:11 INFO - Running setup.py install for mozscreenshot 02:39:11 INFO - Running setup.py install for moztest 02:39:11 INFO - Running setup.py install for mozversion 02:39:12 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:39:12 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:39:12 INFO - Cleaning up... 02:39:12 INFO - Return code: 0 02:39:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:39: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')]} 02:39:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:39: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')]} 02:39:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:39:12 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 0x1ab91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c82a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e25a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e29090>, '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 0x1e29d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e23f90>, '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-1504863418.753420-1283253239', '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 02:39:12 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 02:39:12 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 02:39:12 INFO - Using env: {'DISPLAY': ':0', 02:39:12 INFO - 'HOME': '/home/cltbld', 02:39:12 INFO - 'LANG': 'en_US.UTF-8', 02:39:12 INFO - 'LANGUAGE': 'en_US:en', 02:39:12 INFO - 'LOGNAME': 'cltbld', 02:39:12 INFO - 'MAIL': '/var/mail/cltbld', 02:39:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:39:12 INFO - 'MOZ_NO_REMOTE': '1', 02:39:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:39:12 INFO - 'NO_EM_RESTART': '1', 02:39:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:39:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:39:12 INFO - 'PWD': '/builds/slave/test', 02:39:12 INFO - 'SHELL': '/bin/bash', 02:39:12 INFO - 'SHLVL': '1', 02:39:12 INFO - 'TERM': 'linux', 02:39:12 INFO - 'TMOUT': '86400', 02:39:12 INFO - 'USER': 'cltbld', 02:39:12 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1504863418.753420-1283253239', 02:39:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:39:12 INFO - '_': '/tools/buildbot/bin/python'} 02:39:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:39:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:39:12 INFO - Running setup.py (path:/tmp/pip-Miq6_C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:39:12 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)) 02:39:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:39:12 INFO - Running setup.py (path:/tmp/pip-E_0ob5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:39:12 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)) 02:39:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:39:12 INFO - Running setup.py (path:/tmp/pip-UDvVTB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:39:12 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)) 02:39:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:39:12 INFO - Running setup.py (path:/tmp/pip-xRsx00-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:39:12 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)) 02:39:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:39:12 INFO - Running setup.py (path:/tmp/pip-CQzCHe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:39:12 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)) 02:39:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:39:12 INFO - Running setup.py (path:/tmp/pip-FDIlkz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:39:12 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)) 02:39:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:39:12 INFO - Running setup.py (path:/tmp/pip-_ptU1t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:39:12 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)) 02:39:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:39:12 INFO - Running setup.py (path:/tmp/pip-eEfjgO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:39:12 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)) 02:39:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:39:12 INFO - Running setup.py (path:/tmp/pip-i58J4W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:39:12 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)) 02:39:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:39:12 INFO - Running setup.py (path:/tmp/pip-A8Uqwi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:39:13 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)) 02:39:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:39:13 INFO - Running setup.py (path:/tmp/pip-k8CpkL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:39:13 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)) 02:39:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:39:13 INFO - Running setup.py (path:/tmp/pip-JmXb0y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:39:13 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)) 02:39:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:39:13 INFO - Running setup.py (path:/tmp/pip-Ngbr5j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:39:13 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)) 02:39:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:39:13 INFO - Running setup.py (path:/tmp/pip-mUUes4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:39:13 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)) 02:39:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:39:13 INFO - Running setup.py (path:/tmp/pip-2Xl8EK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:39:13 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)) 02:39:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:39:13 INFO - Running setup.py (path:/tmp/pip-_ST8eo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:39:13 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)) 02:39:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:39:13 INFO - Running setup.py (path:/tmp/pip-rsswjp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:39:13 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)) 02:39:13 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)) 02:39:13 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)) 02:39:13 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)) 02:39:13 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)) 02:39:13 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)) 02:39:13 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)) 02:39:13 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:39:13 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 02:39:13 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 02:39:13 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 02:39:13 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 02:39:14 INFO - Downloading blessings-1.6.tar.gz 02:39:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:39:14 INFO - Installing collected packages: blessings 02:39:14 INFO - Running setup.py install for blessings 02:39:14 INFO - Successfully installed blessings 02:39:14 INFO - Cleaning up... 02:39:14 INFO - Return code: 0 02:39:14 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:39:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:39:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:39:15 INFO - Reading from file tmpfile_stdout 02:39:15 INFO - Current package versions: 02:39:15 INFO - argparse == 1.2.1 02:39:15 INFO - blessings == 1.6 02:39:15 INFO - blobuploader == 1.2.4 02:39:15 INFO - docopt == 0.6.1 02:39:15 INFO - functools32 == 3.2.3-2 02:39:15 INFO - jsonschema == 2.5.1 02:39:15 INFO - manifestparser == 1.1 02:39:15 INFO - mozInstall == 1.13 02:39:15 INFO - mozcrash == 1.0 02:39:15 INFO - mozdebug == 0.1 02:39:15 INFO - mozdevice == 0.51 02:39:15 INFO - mozfile == 1.2 02:39:15 INFO - mozhttpd == 0.7 02:39:15 INFO - mozinfo == 0.10 02:39:15 INFO - mozleak == 0.1 02:39:15 INFO - mozlog == 3.5 02:39:15 INFO - moznetwork == 0.27 02:39:15 INFO - mozprocess == 0.25 02:39:15 INFO - mozprofile == 0.28 02:39:15 INFO - mozrunner == 6.13 02:39:15 INFO - mozscreenshot == 0.1 02:39:15 INFO - mozsystemmonitor == 0.3 02:39:15 INFO - moztest == 0.8 02:39:15 INFO - mozversion == 1.4 02:39:15 INFO - psutil == 3.1.1 02:39:15 INFO - requests == 1.2.3 02:39:15 INFO - wsgiref == 0.1.2 02:39:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:39:15 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')]} 02:39:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:39:15 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')]} 02:39:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:39:15 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 0x1ab91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c82a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e25a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e29090>, '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 0x1e29d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e23f90>, '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-1504863418.753420-1283253239', '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 02:39:15 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 02:39:15 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 02:39:15 INFO - Using env: {'DISPLAY': ':0', 02:39:15 INFO - 'HOME': '/home/cltbld', 02:39:15 INFO - 'LANG': 'en_US.UTF-8', 02:39:15 INFO - 'LANGUAGE': 'en_US:en', 02:39:15 INFO - 'LOGNAME': 'cltbld', 02:39:15 INFO - 'MAIL': '/var/mail/cltbld', 02:39:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:39:15 INFO - 'MOZ_NO_REMOTE': '1', 02:39:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:39:15 INFO - 'NO_EM_RESTART': '1', 02:39:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:39:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:39:15 INFO - 'PWD': '/builds/slave/test', 02:39:15 INFO - 'SHELL': '/bin/bash', 02:39:15 INFO - 'SHLVL': '1', 02:39:15 INFO - 'TERM': 'linux', 02:39:15 INFO - 'TMOUT': '86400', 02:39:15 INFO - 'USER': 'cltbld', 02:39:15 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1504863418.753420-1283253239', 02:39:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:39:15 INFO - '_': '/tools/buildbot/bin/python'} 02:39:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:39:15 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)) 02:39:15 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)) 02:39:15 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)) 02:39:15 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)) 02:39:15 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)) 02:39:15 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)) 02:39:15 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)) 02:39:15 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)) 02:39:15 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)) 02:39:15 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 02:39:15 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 02:39:15 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 02:39:15 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 02:39:15 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 02:39:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 02:39:16 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)) 02:39:16 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)) 02:39:16 INFO - Installing collected packages: simplejson 02:39:16 INFO - Running setup.py install for simplejson 02:39:16 INFO - building 'simplejson._speedups' extension 02:39:16 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 02:39:17 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 02:39:17 INFO - Successfully installed simplejson 02:39:17 INFO - Cleaning up... 02:39:17 INFO - Return code: 0 02:39:17 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:39:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:39:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:39:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:39:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:39:17 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 0x1ab91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c82a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e25a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e29090>, '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 0x1e29d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e23f90>, '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-1504863418.753420-1283253239', '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 02:39:17 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 02:39:17 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 02:39:17 INFO - Using env: {'DISPLAY': ':0', 02:39:17 INFO - 'HOME': '/home/cltbld', 02:39:17 INFO - 'LANG': 'en_US.UTF-8', 02:39:17 INFO - 'LANGUAGE': 'en_US:en', 02:39:17 INFO - 'LOGNAME': 'cltbld', 02:39:17 INFO - 'MAIL': '/var/mail/cltbld', 02:39:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:39:17 INFO - 'MOZ_NO_REMOTE': '1', 02:39:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:39:17 INFO - 'NO_EM_RESTART': '1', 02:39:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:39:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:39:17 INFO - 'PWD': '/builds/slave/test', 02:39:17 INFO - 'SHELL': '/bin/bash', 02:39:17 INFO - 'SHLVL': '1', 02:39:17 INFO - 'TERM': 'linux', 02:39:17 INFO - 'TMOUT': '86400', 02:39:17 INFO - 'USER': 'cltbld', 02:39:17 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1504863418.753420-1283253239', 02:39:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:39:17 INFO - '_': '/tools/buildbot/bin/python'} 02:39:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:39:17 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:39:17 INFO - Cleaning up... 02:39:17 INFO - Return code: 0 02:39:17 INFO - Running post-action listener: _resource_record_post_action 02:39:17 INFO - Running post-action listener: _start_resource_monitoring 02:39:17 INFO - Starting resource monitoring. 02:39:17 INFO - [mozharness: 2017-09-08 09:39:17.787858Z] Finished create-virtualenv step (success) 02:39:17 INFO - [mozharness: 2017-09-08 09:39:17.788361Z] Running install step. 02:39:17 INFO - Running pre-action listener: _resource_record_pre_action 02:39:17 INFO - Running main action method: install 02:39:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:39:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:39:18 INFO - Reading from file tmpfile_stdout 02:39:18 INFO - Detecting whether we're running mozinstall >=1.0... 02:39:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:39:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:39:18 INFO - Reading from file tmpfile_stdout 02:39:18 INFO - Output received: 02:39:18 INFO - Usage: mozinstall [options] installer 02:39:18 INFO - Options: 02:39:18 INFO - -h, --help show this help message and exit 02:39:18 INFO - -d DEST, --destination=DEST 02:39:18 INFO - Directory to install application into. [default: 02:39:18 INFO - "/builds/slave/test"] 02:39:18 INFO - --app=APP Application being installed. [default: firefox] 02:39:18 INFO - mkdir: /builds/slave/test/build/application 02:39:18 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'] 02:39:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 02:39:34 INFO - Reading from file tmpfile_stdout 02:39:34 INFO - Output received: 02:39:34 INFO - /builds/slave/test/build/application/firefox/firefox 02:39:34 INFO - Running post-action listener: _resource_record_post_action 02:39:34 INFO - [mozharness: 2017-09-08 09:39:34.692894Z] Finished install step (success) 02:39:34 INFO - [mozharness: 2017-09-08 09:39:34.693208Z] Running setup-mitmproxy step. 02:39:34 INFO - Running pre-action listener: _resource_record_pre_action 02:39:34 INFO - Running main action method: setup_mitmproxy 02:39:34 INFO - Skipping: mitmproxy is not required 02:39:34 INFO - Running post-action listener: _resource_record_post_action 02:39:34 INFO - [mozharness: 2017-09-08 09:39:34.694336Z] Finished setup-mitmproxy step (success) 02:39:34 INFO - [mozharness: 2017-09-08 09:39:34.694553Z] Running run-tests step. 02:39:34 INFO - Running pre-action listener: _resource_record_pre_action 02:39:34 INFO - Running pre-action listener: _set_gcov_prefix 02:39:34 INFO - Running main action method: run_tests 02:39:34 WARNING - Try message not found. 02:39:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:39:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:39:34 INFO - Python 2.7.3 02:39:34 INFO - Return code: 0 02:39:34 INFO - grabbing minidump binary from tooltool 02:39:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:39:34 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--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 0x1e29090>, '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 0x1e29d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e23f90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:39:34 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--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 02:39:34 INFO - Copy/paste: /tools/tooltool.py --url https://tooltool.mozilla-releng.net/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 02:39:34 INFO - Calling ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--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 02:39:34 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:39:34 INFO - Return code: 0 02:39:34 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 02:39:34 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:39:34 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:39:34 INFO - ENV: RUST_BACKTRACE is now full 02:39:34 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 02:39:34 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:39:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-stylo-disabled-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bhya0MgVT7S5tIHCfYUKiw/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-stylo-disabled-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log'] in /builds/slave/test/build 02:39:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-stylo-disabled-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/bhya0MgVT7S5tIHCfYUKiw/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-stylo-disabled-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log 02:39:34 INFO - Using env: {'DISPLAY': ':0', 02:39:34 INFO - 'HOME': '/home/cltbld', 02:39:34 INFO - 'LANG': 'en_US.UTF-8', 02:39:34 INFO - 'LANGUAGE': 'en_US:en', 02:39:34 INFO - 'LOGNAME': 'cltbld', 02:39:34 INFO - 'MAIL': '/var/mail/cltbld', 02:39:34 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:39:34 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:39:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:39:34 INFO - 'MOZ_NO_REMOTE': '1', 02:39:34 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:39:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:39:34 INFO - 'NO_EM_RESTART': '1', 02:39:34 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:39:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:39:34 INFO - 'PWD': '/builds/slave/test', 02:39:34 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:39:34 INFO - 'RUST_BACKTRACE': 'full', 02:39:34 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 02:39:34 INFO - 'SHELL': '/bin/bash', 02:39:34 INFO - 'SHLVL': '1', 02:39:34 INFO - 'TERM': 'linux', 02:39:34 INFO - 'TMOUT': '86400', 02:39:34 INFO - 'USER': 'cltbld', 02:39:34 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1504863418.753420-1283253239', 02:39:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:39:34 INFO - '_': '/tools/buildbot/bin/python'} 02:39:34 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-stylo-disabled-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bhya0MgVT7S5tIHCfYUKiw/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-stylo-disabled-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log'] with output_timeout 3600 02:39:35 INFO - mozversion application_buildid: 20170908085005 02:39:35 INFO - mozversion application_changeset: dd75dcec7da162d8ceaaf0883e0e7561bd772992 02:39:35 INFO - mozversion application_display_name: Nightly 02:39:35 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:39:35 INFO - mozversion application_name: Firefox 02:39:35 INFO - mozversion application_remotingname: firefox 02:39:35 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 02:39:35 INFO - mozversion application_vendor: Mozilla 02:39:35 INFO - mozversion application_version: 57.0a1 02:39:35 INFO - mozversion platform_buildid: 20170908085005 02:39:35 INFO - mozversion platform_changeset: dd75dcec7da162d8ceaaf0883e0e7561bd772992 02:39:35 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 02:39:35 INFO - mozversion platform_version: 57.0a1 02:39:35 INFO - using testdate: 1504863575 02:39:35 INFO - actual date: 1504863575 02:39:35 INFO - starting webserver on 'localhost:44967' 02:39:35 INFO - SUITE-START | Running 2 tests 02:39:35 INFO - TEST-START | dromaeo_css 02:39:35 INFO - Initialising browser for dromaeo_css test... 02:39:35 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:44967/getInfo.html -profile /tmp/tmpwAwrWh/profile 02:39:35 INFO - TEST-INFO | started process 7640 (/builds/slave/test/build/application/firefox/firefox http://localhost:44967/getInfo.html) 02:39:40 INFO - TEST-INFO | 7640: exit 0 02:39:40 INFO - Browser initialized. 02:39:40 INFO - Running cycle 1/1 for dromaeo_css test... 02:39:40 INFO - Using env: {'DISPLAY': ':0', 02:39:40 INFO - 'HOME': '/home/cltbld', 02:39:40 INFO - 'JSGC_DISABLE_POISONING': '1', 02:39:40 INFO - 'LANG': 'en_US.UTF-8', 02:39:40 INFO - 'LANGUAGE': 'en_US:en', 02:39:40 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 02:39:40 INFO - 'LOGNAME': 'cltbld', 02:39:40 INFO - 'MAIL': '/var/mail/cltbld', 02:39:40 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:39:40 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:39:40 INFO - 'MOZ_CRASHREPORTER': '1', 02:39:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:39:40 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 02:39:40 INFO - 'MOZ_NO_REMOTE': '1', 02:39:40 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:39:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:39:40 INFO - 'NO_EM_RESTART': '1', 02:39:40 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:39:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:39:40 INFO - 'PWD': '/builds/slave/test', 02:39:40 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:39:40 INFO - 'RUST_BACKTRACE': 'full', 02:39:40 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 02:39:40 INFO - 'SHELL': '/bin/bash', 02:39:40 INFO - 'SHLVL': '1', 02:39:40 INFO - 'STYLO_FORCE_DISABLED': '1', 02:39:40 INFO - 'TERM': 'linux', 02:39:40 INFO - 'TMOUT': '86400', 02:39:40 INFO - 'USER': 'cltbld', 02:39:40 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1504863418.753420-1283253239', 02:39:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:39:40 INFO - '_': '/tools/buildbot/bin/python'} 02:39:40 INFO - TEST-INFO | started process 7835 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwAwrWh/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 02:39:41 INFO - PID 7835 | 02:39:41 INFO - PID 7835 | (/builds/slave/test/build/application/firefox/firefox:7886): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 02:39:41 INFO - PID 7835 | 02:39:51 INFO - PID 7835 | RSS: Main: 169644032 02:39:51 INFO - PID 7835 | 02:42:49 INFO - PID 7835 | Cycle 1(1): loaded http://localhost:44967/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44967/tests/dromaeo/cssquery-ext.html) 02:42:50 INFO - PID 7835 | RSS: Main: 172154880 02:42:50 INFO - PID 7835 | 02:45:52 INFO - PID 7835 | Cycle 1(1): loaded http://localhost:44967/tests/dromaeo/cssquery-ext.html (next: http://localhost:44967/tests/dromaeo/cssquery-jquery.html) 02:45:52 INFO - PID 7835 | RSS: Main: 168636416 02:45:52 INFO - PID 7835 | 02:48:54 INFO - PID 7835 | Cycle 1(1): loaded http://localhost:44967/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44967/tests/dromaeo/cssquery-mootools.html) 02:48:55 INFO - PID 7835 | RSS: Main: 170795008 02:48:55 INFO - PID 7835 | 02:51:56 INFO - PID 7835 | Cycle 1(1): loaded http://localhost:44967/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44967/tests/dromaeo/cssquery-prototype.html) 02:51:57 INFO - PID 7835 | RSS: Main: 169299968 02:51:57 INFO - PID 7835 | 02:55:00 INFO - PID 7835 | Cycle 1(1): loaded http://localhost:44967/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44967/tests/dromaeo/cssquery-yui.html) 02:55:01 INFO - PID 7835 | RSS: Main: 169066496 02:55:01 INFO - PID 7835 | 02:58:03 INFO - PID 7835 | Cycle 1(1): loaded http://localhost:44967/tests/dromaeo/cssquery-yui.html (next: http://localhost:44967/tests/dromaeo/cssquery-dojo.html) 02:58:03 INFO - PID 7835 | RSS: Main: 173834240 02:58:03 INFO - PID 7835 | 02:58:03 INFO - PID 7835 | __start_tp_report 02:58:03 INFO - PID 7835 | _x_x_mozilla_page_load 02:58:03 INFO - PID 7835 | _x_x_mozilla_page_load_details 02:58:03 INFO - PID 7835 | |i|pagename|runs| 02:58:03 INFO - PID 7835 | |0;dojo.html;3045.451818672639;3087.459694553453;3115.8753649853993;3123.9219019524508;3148.511980643001;6070.484008859241;6220.595661282025;6255.718492667829;6296.370362963696;6326.430621244087;6164.691765411722;6238.376162383759;6258.655773932432;6286.874262514747;6287.559870809046;5764.279465066867;5778.191053252537;5792.71036448178;5794.188813566104;5811.6803575803315;5746.109353050263;5801.593888427812;5808.390119037483;5886.705664716768;5901.498372638331;5815.709214539256;5845;5907.970460147715;5922;5940.316863560703;5596.664200148004;5831;5832.912506312408;5873.324567674708;5903.881922361572;5321.414644389114;5622.3253209614695;5661.716914154317;5664.518515926151;5721.399253078408;6213.409726076015;6240;6307.400796924331;6317.305096439388;6344.302126766052;6660.433863121641;6666.466682665375;6673.5662181958505;6749.898751518731;6751.831204219885;6714.362135597111;6725.461963042945;6770.255271920085;6771.8984215236815;6779.2881747416795;6257.624542527417;6339.619622822645;6344.397282258178;6345.270293916213;6347.1114044033875;6900.758473453405;6910.896336554855;7006.50954433195;7012.7545535906;7026.051483049825;6424.935750642528;6534.9673251634385;6552.180977377828;6553.475721942234;6595.274519802818;6579.276279609239;6642.269350371455;6652.8669426611195;6652.966735166293;6661.367170118831;6621.801345959629;6678.666066696743;6756.729730810811;6761.290064543152;6795.456363490909;6696.698648560827;6769.39075483199;6799.32006799326;6801.1838579369805;6806.285340039323;5239.633225674243;5280.392754833243;5319.654222475527;5326.201069839555;5329.706866122323;4557.863264102082;4563.954360456353;4573.611243044312;4585.816567337336;4651.930221046687;5728.083506638918;5741.110127930177;5743.10981797822;5743.195952566644;5744.942550574524;6644.867102658017;6690.565113267622;6780.627065511444;6782.593044417351;6783.660816959133;5775.768969241183;5824.301083869963;5852.239208902815;5852.941470585325;5853.560982926212;5769.336526299446;5775.27809023872;5846.912296315559;5856.619319744203;5859.414058594107;6286.811395658137;6381.840453988594;6391.424771770563;6466.902996455057;6549;6677.465802735769;6707.29573394806;6713.832154196184;6714.127163468718;6715.227748808852;6356.618602883842;6419.839504012437;6441.935580644321;6442.484601231984;6451.225852897683;6613.503987200883;6630.038644396439;6651.866962660816;6669.7332106715185;6744.966275168593;6739.157605299338;6759.053732477555;6833.350831670983;6834.077399550997;6837.897431538431;6357.682115894094;6476;6479.676016199265;6490.156279683611;6500.057491663777;6347.96826015867;6414.198225221848;6442.065900444503;6442.903356449563;6449.419552240321;6329.082283069021;6375.840603984752;6418.775342863164;6498.0252962056065;6544.869102618016;6538.705758240795;6541.051547525677;6581.407673309425;6622.37087476689;6645.767398141042;6230.7507699693315;6346.587471814318;6429.35706429372;6430.967845160744;6435.292117866938 02:58:03 INFO - PID 7835 | |1;ext.html;831.567584855875;874.6719980007497;874.8250349930014;876.9561521923906;880.5685214245018;39053.80473097634;39826.40260396093;42707.145857082876;42964.14071718564;42997;40258.7987060065;40526.39210411846;40587.188256234855;40632.796836015776;40655.39016914749;7103.573785572869;7248.420126389876;7250.383717384028;7251.456140789435;7644.808879778022;7748.883766743504;7866.803329916741;7868.213178682143;7870.252326029018;7875.369970402354;7809.258120478546;7822.921770782276;7888.723894663688;7891.053073631172;7891.092524359715;7922.603869806516;7997.880031799469;7998.12020677725;8010.5594192319395;8019;7733.381329493684;7789.649465774054;7792.532448053135;7798.298153166243;7800.4149688773;38923.610763892284;39011.609883901365;39207.21585568301;39314.60685393138;39348;3566.857325706969;3575.982120089383;3577.9821100894587;3578.8926332210076;3606.026372879308;31828.522572161437;32145.357092858245;32184.83907580447;32285.677143228735;32303;5162.096633089232;5167.431582525919;5169.172932330809;5211.166213405875;5221.321228240343;186249;186695;187420;188064;188634.99999999863;42227.57772422236;47800.28299575509;47925.04149916982;48042.75978620085;48288;44880.77559612181;52361;53044.734776326644;53076;53130.46869531255;14829.480968166063;14955.551333460013;14958.102513849204;14966.251687415586;14999.175045372609;11842.940785296018;11883.227590206609;11883.821742673867;11891.108166887345;11897;14314.498992535211;14339.139651620937;14359.497417590333;14432;14542.854571454362;5641.294838145232;5770.88458230833;5775.451332123442;5890.14592884038;5937.4359435854385;1023.559869256227;1031.5409642709074;1037.8806437259661;1040.1159014837478;1051.1643243621186;23153.421164470685;23331.650025249633;23396.766032339798;23458.320421444176;23875.283741487783;1117.9049780768726;1121.0471099565304;1122.2368789223406;1133.4276190523897;1143.8684551276542;11967.22213056166;12318.876811231952;12366.814497782541;12508.437120329607;12555.435005424777;234098;235440;235447;235710;235965;54432.727836360566;54657.45342546603;54674;54746.17880731792;54810;1449.154332480227;1455.097839339595;1460.5545308680742;1481.8444063373406;1484.5249520153448;23014;23126.653100203846;23270.069197231922;23392.64911026302;23445.76554234504;38072.61927380691;38131;38145.61854381532;38184.236315274095;38217.80891095527;201181;201375;201522;201744;202100;34190.31619367649;34882;36642;36860.81569592135;36875.44686829646;46292.768536157106;47284;47296.763516182196;47358.28962565495;47518;34047.319053618296;34177.82911085528;34278.82860585681;34613;34655.82672086624;33638.66361336453;33730.32539349249;33864;34082.31835363329;34623.82688086543;37870.81064594659;38024.429633554966;38091;38096.428553572274;38690.41964370593;32145.196370090936;32440.675593243766;32583;33026.83486582552;33167.83416082904;23603.52792944097;23847.761522384553;23850.52298954046;24558.754412455648;24611.753882461664 02:58:03 INFO - PID 7835 | |2;jquery.html;561.278756797515;566.9291338582677;567.4609121334734;568.9743961521731;591.1310373750588;22069.889650551766;22929.656055159187;22935.19726809562;22980.195693150745;22993.770062299373;23257.418564535896;24280.150194743186;24375.14686985956;24564.508709825794;24917.75082249177;6585.769498067557;6784.9321506785045;6787.389134977851;6788.626625535593;6788.626625535593;6422.743090276406;6649.335066493336;6741.359570840762;6772.424343930772;6772.627505487197;6692.93307066928;6704.83237919051;6707.1616047994;6719.63042032688;6719.7312107515645;6397.4242318191355;6711.228208756007;6711.463082953352;6713.362230588086;6716;6235.407636274546;6237.469815065725;6240.063990401431;6257.342978987232;6257.56197066201;28388.29029274264;28814.567781483296;28834;28898.711012890024;29008.854955725088;2063;2092;2094.2565389286888;2095.057224249079;2098.3914664747203;19039.61920761577;19410;19637.607247855107;19728.11223494932;19887.900560497248;2268.4215525041172;2324.6164382876805;2332.428555004018;2429.4047958250344;2497.1384872219055;117209.41395293054;122347;133241;136915;143352.99999999895;13978.231197284043;14310.427582896567;14470.302051428524;14663;14691.89810764197;22390.776092239194;22394.32817015492;22406.215782447536;22454;22461.213857514907;9956.551955162035;10220.182385409149;10272.794544109076;10331.380117192992;10483.161347092368;9656.275779316438;9657.565409556586;9660.275479339078;9773.804523909483;9834.901650983542;8898.59956301955;8898.644054237888;8911.866322005175;9032.187103160748;9221.769455763659;2536.3151948973673;2563.115725074846;2628.172125780373;2679.4641071785722;2705.4578890032494;931.6925414613297;951.3768481644533;963.1861077389594;968.6367612145445;972.8832540095234;18380.17289221988;18578.814211857978;19020.904895475433;19090.14094365757;19172.90413547923;1012.4026824173773;1020.2348238820884;1032.4166845732138;1033.6537260017828;1035.4615599888016;10249.692509224735;10475.47622618866;10591.682249532527;10688.198385121146;10739.248252622241;462701;468259;473912;484428;491057;103161.48419258006;104155;105978.47010765052;106064.46967765265;107274;1015.4364327797995;1152.3719572832827;1172.865120511135;1178.3519064514483;1181.2794195540714;19508.804911950698;19688.606227875647;19738.40784776459;19831.206751730348;20300.390988270374;52831.735841320544;54148;54404.72797635986;54425.455745442036;55411.44588554063;65118;66419;67815.3218467809;68243.65878170577;68601.31398685949;13130;13263.734725305632;13342.26617536006;14088.506902258372;14090.154590724589;22047.559048819254;22085.33743987683;22102.668459973436;22365.552688946456;22388.32835014952;17250.65498690044;17386.652266954337;17502.562435939202;17652.823471765118;17730.468085957444;14891.180985045927;15219.086854788748;15775.447859324868;15916.522504324888;16358.509244722678;17066.232019559397;17868.106594670473;17938.461846144637;17978.5505362367;18030.63938721192;13930.164190148624;13977.708479431787;14011;14018.369173387018;14018.579442616738;17509.474715758548;17555.210015549077;17589;17627.735583965994;17679 02:58:03 INFO - PID 7835 | |3;mootools.html;1328.1765305510585;1386.299918541138;1386.7434524612947;1390.0339264211375;1390.2909516146763;14873.999999999987;16051.83948160518;16204.513864584067;16223.756643650355;16225.675486490292;15878.52364429066;16159.272832722527;16160.191990400492;16172.75740863888;16172.83827161731;2773.320536468568;2838.4323135372906;2842.815217010888;2845.3597940463437;2846.131929761422;2679.6918354389204;2729.890804367823;2782.0819129687256;2783.025940920682;2790.1071657069747;2648.2055383385004;2672.345275407528;2721.306066952934;2740.931476713088;2743.3278846682592;2800.9299767505872;2808.255812209766;2828.8302701837956;2834.1922552072665;2843.7298456646586;2667.9333016674736;2681.9597706034424;2686.288133644566;2693.420914503391;2694.124409566879;14367.712645747131;14590.051646642934;14600.780988285183;14606.926965365212;14608.269586520737;7797.805054873674;8120.472169309035;8122.796930076736;8133.349332053422;8140.226678465596;5340.946590534084;5424;5489.780408783644;5511.751971161308;5581.358143813472;1952.3362056900721;1955;1963.7054441833695;2012.0845015517905;2016.7378240828598;26831.73168268312;26884.865575672193;27047.323816904536;27065.729342706516;27090.729092709018;6390.7763228286785;6558.80323590293;6621.5364924454825;6730.798076057726;6788.558743681645;17625.206865691074;17646.823531764774;17653.293868245382;17653.646927061385;17672.38146664886;7699.576523291273;7825.413094017971;7826.060872695313;7829.804254893673;7862.921370786334;7033.261507541737;7131.964340178266;7200.243974382719;7262.237465066092;7274.30894065063;5195.896082078338;5330.333708286465;5367.731613419392;5388.676679399248;5421.105517589633;1374.9518766843112;1395.9790603140962;1507.0580886945659;1520.4146403634459;1526.625976635709;878.1964502480287;917.605429665237;928.6053427293373;934.2992755433424;934.4393363981557;8683.86974195375;8719.60761765722;8728.563571821383;8733.694320698745;8755.430896991675;975.0931633580838;978.7993461340408;995.9203263738883;1001.0390025575383;1022.6880801355509;4537;4556.134334476439;4674.97662511692;5205.609579281569;5221.817236396784;20474;20712.275070372463;21249.150033998467;21447.78552214489;21475.355739327846;20796.168153274004;21560.676589851166;21645;21747;21810.563788724136;11291.322520648788;11459.77080458386;11464.4840982156;11508.654740357802;11514.19400641947;8428.241458268785;8511.404201705822;8521.44610600309;8588.441751286146;8618.65525379003;18382;18629.534261643566;18802;18974.810251897303;19019.144138513522;18314.908425457787;18824.435266942015;18951.620967580846;19027.619447611247;19170;10147.188224942134;10293.53679084458;10360.948195258976;10362.119219866396;10373.429461379697;13441.327933603085;13622.523211687543;13625.523106691218;13635.931820341231;13660;11309.547618095185;11368.602098926498;11407.25852819564;11498.425078746197;11752.941235293769;10856.891431085589;10951;10966.561337546409;11076.113910886948;11336.149788765711;9230.769230769285;9358.812823743623;9380;9387.389819661701;9388.718338449857;7156.248593897774;7170.892436613351;7230.168530619047;7239.239879812544;7276.090488688914;6838;6935.549189302679;6974.895376569254;6988.685509152202;6992.965035174995 02:58:03 INFO - PID 7835 | |4;prototype.html;495.23486213799674;517.2035065998363;528.493792690831;528.9444608316127;537.073548129477;6008.24896887889;6190.442860142592;6270.31026587075;6299.905501417483;6382.808515744529;6189.29794306566;6223.097650840626;6245;6258.593191442553;6278.717457714402;5156.432792392834;5191.117510023286;5228.47715228478;5243.973780131094;5255.421903590602;4935.259711043336;5075.847724568251;5157.575939308519;5228.777769447988;5229.7385130743505;5244.737763111848;5247.816326428576;5272.604554658396;5279.815206467774;5284.656497327681;5213.905079933237;5215.191645294966;5265.605079619006;5299.417064122943;5305.602079844027;4822.252550854623;4872.366592343008;4877.975610121962;4881.902361952741;4894.632902532288;6216.222972128484;6235.781747638856;6292.150559674431;6323.024741619171;6333.1766870306565;5981.760729570812;6031.6079454835735;6044.304904935944;6054.939450605481;6080.695965201722;6516.413522782972;6525.869482610321;6551.312112228243;6602.93397066028;6736.393724564764;5236.973815130938;5238.947610523884;5243.370795504564;5313.38896026958;5336.30628018359;6955.721771129149;6962.408195303456;7010.789676309719;7021.841396169575;7071.469639777038;5356.892862142735;5464.863378415572;5468.945310546923;5482.835514934479;5483.479069488392;5573.4394369576585;5574.58190635704;5575.4424557543925;5598.692071936001;5603.243562119062;5988.700564971734;5990.700464976734;6028.457438830526;6062.2725272966645;6078.149059131725;6589.968614437413;6641.734330626818;6678.565893216925;6682.264950855402;6698.129243198353;1781.8930864148192;1836.173721825184;1843.4469659102215;1868.0472958791115;1880.3700760245472;1368.3773882883265;1391.5964370332692;1432.5917113622568;1434.8206474190727;1451.4702133721328;5733.627314224562;5742.196092547047;5761.8559536011935;5769.163471296639;5803.970980145073;6456.903146452807;6649.60102393858;6683.4987375947;6739.797806065826;6773.762918297934;5660.85847853807;5697.515711164598;5712.058289980663;5729.713514324267;5786.334571524329;3446.827658617059;3501.8949431517094;3524.4360902255517;3549.378858699717;3579.3378225028455;6443.581167224115;6462.3537646235;6478.384553467413;6518.837029074311;6533.18335208099;6801.829954251084;6827.658617069127;6896.3103689631635;6916.896246556305;6930;6385.936140638534;6394.712237949303;6411.871762564816;6463.741450342028;6523.249826269945;6677.43241824431;6751.797446076625;6751.93248067513;6783;6794.898076528955;6740.595564266159;6775.966120169368;6798;6820.658967051529;6839.6580170990255;6445.291017988111;6454.838629034311;6484.740610375721;6507.414332710079;6555.2789193189665;4949.82675606352;4980.775865086008;4984.302197692254;5004.199328107486;5031.371078615173;6524.368907773057;6665.166854143232;6782.220044694726;6853.760118395832;6870.553414028072;6031.60794548353;6414.198225221848;6493.8701225976165;6527.575707579183;6539.6403197824575;6358.598149989733;6420.26166990802;6423.903641445476;6488.967555162194;6490.610563366213;6316.147320111726;6337.8732425352155;6358.268799088164;6400.39196276353;6493.22081350241;6470.255920569007;6577.079208910852;6647.734090636321;6670.733170673118;6674.16572928384;6372.299047104722;6393.808185754435;6401.391867772741;6410.423061924449;6422.967885160544 02:58:03 INFO - PID 7835 | |5;yui.html;899.1907283444899;901.535709109809;903.0788595632455;906.3066753933238;932.9393589416687;19206.423807285788;19983.60032799345;19986.40040798775;20058.89970550147;20081.196752129934;16746.58133546662;16889.493315200532;16891.746623800653;16925.492235232963;16977.745333820003;906.5150144672601;918.6968300460866;921.1617428140394;921.1893533690377;921.4655499810127;978.427619842393;979.8775153105862;986.6201512417699;987.3483500889414;987.4075554667178;1018.2159737002504;1025.0723095598496;1042.598599539179;1044.738815296176;1047.6752206815872;1039.1271332081087;1039.1790485516433;1039.469870366115;1040.2614143957762;1040.9479526023706;730.9853802923965;747.6598147842718;753.6231884057971;756.5120497279224;756.7994481462362;19035.048247587565;19216.423507294665;19220.615587688168;19222.03889805518;19228.519287017938;21543.569128617495;21755.456113597127;22503;22569.66145507819;22572;16997;17054.232559534852;17326.306947722074;17393;17637.911810440994;3741.27045226181;3744.719146064056;3762.6801721853676;3769.4157405602177;3778.6599206071587;100246.5636119358;114268;144546.277268613;146009.26995365063;147680;15209.315580798891;15467.149306788235;15550.300236489385;15668.138252396;15744.68510629781;27518.724812751618;27829.860850695615;27876.16371508858;27903.441931161262;27911.720882790913;9037;9108.271338293052;9123.315751318678;9168.404053736485;9217.44695318283;4298.76356800379;4355.629771469397;4362.541933097043;4372.956270437255;4373.890652733707;5063.164577844688;5166.147585648401;5167.22491626259;5180.766865491062;5186.196139598368;1017.9898201018043;1040.147079394889;1046.0742243114898;1047.9685609431729;1048.4652827058255;672.1060988884772;685.4276678973014;687.285223367692;688.084847153285;701.193627328566;10689.465526723632;11079.224454288122;11369.488373023234;11881.93062624368;12571;660.313274194832;663.0584569910739;667.5227212542958;671.94840075283;676.9458443324522;5327.200919861974;5363.999980026026;5398.946010539844;5404.351477822686;5456.863578410572;127665.36167319104;128696;128966.06550901744;130123.34938325248;132167.33916330358;111523.44238278757;112693.4365328168;113580.43209783899;115469;115546;99498.50250748845;100339.49151271276;101482;103236.48381758043;103573.99999999849;9981.401115933068;10018.298719089886;10052.296339256181;10092.54583543757;10115.342502737298;44451.55548444474;44902.77548612236;45238;46497.53502465067;47092.52907471018;58203.4179658198;58221.70889145527;58474;59341.40658593359;61207;15673.608159796097;15783.131927744083;15822.208889555246;15998.120103394425;16164.434244801376;15550.377984880479;15553.688926221186;15560.299786509408;15694.607634809221;15707.921460392625;13201.537946171838;13448.46206151743;13493.527726529524;13540.390682419118;13552.119112257671;12782.808257875953;12901.096923215286;12967.027472939379;12989.935050324688;13078.934605326913;13498.730025399633;13500.797488037491;13531.458741650618;13653.658658533615;13687.726245475234;10514.264001520127;10667.51996160159;10728.89271107279;10838.891611084104;11084.16868734832;11094.833577496505;11103.777924441627;11121.332720036824;11226.831597526207;11290.887091129312 02:58:03 INFO - PID 7835 | __end_tp_report 02:58:03 INFO - PID 7835 | __start_cc_report 02:58:03 INFO - PID 7835 | _x_x_mozilla_cycle_collect,367 02:58:03 INFO - PID 7835 | __end_cc_report 02:58:03 INFO - PID 7835 | __startTimestamp1504864683325__endTimestamp 02:58:03 INFO - PID 7835 | 02:58:03 INFO - PID 7835 | ------- Summary: start ------- 02:58:03 INFO - PID 7835 | Number of tests: 6 02:58:03 INFO - PID 7835 | 02:58:03 INFO - PID 7835 | [#0] dojo.html Cycles:165 Average:6166.44 Median:6375.84 stddev:743.40 (11.7%) stddev-sans-first:704.21 02:58:03 INFO - PID 7835 | Values: 3045.5 3087.5 3115.9 3123.9 3148.5 6070.5 6220.6 6255.7 6296.4 6326.4 6164.7 6238.4 6258.7 6286.9 6287.6 5764.3 5778.2 5792.7 5794.2 5811.7 5746.1 5801.6 5808.4 5886.7 5901.5 5815.7 5845.0 5908.0 5922.0 5940.3 5596.7 5831.0 5832.9 5873.3 5903.9 5321.4 5622.3 5661.7 5664.5 5721.4 6213.4 6240.0 6307.4 6317.3 6344.3 6660.4 6666.5 6673.6 6749.9 6751.8 6714.4 6725.5 6770.3 6771.9 6779.3 6257.6 6339.6 6344.4 6345.3 6347.1 6900.8 6910.9 7006.5 7012.8 7026.1 6424.9 6535.0 6552.2 6553.5 6595.3 6579.3 6642.3 6652.9 6653.0 6661.4 6621.8 6678.7 6756.7 6761.3 6795.5 6696.7 6769.4 6799.3 6801.2 6806.3 5239.6 5280.4 5319.7 5326.2 5329.7 4557.9 4564.0 4573.6 4585.8 4651.9 5728.1 5741.1 5743.1 5743.2 5744.9 6644.9 6690.6 6780.6 6782.6 6783.7 5775.8 5824.3 5852.2 5852.9 5853.6 5769.3 5775.3 5846.9 5856.6 5859.4 6286.8 6381.8 6391.4 6466.9 6549.0 6677.5 6707.3 6713.8 6714.1 6715.2 6356.6 6419.8 6441.9 6442.5 6451.2 6613.5 6630.0 6651.9 6669.7 6745.0 6739.2 6759.1 6833.4 6834.1 6837.9 6357.7 6476.0 6479.7 6490.2 6500.1 6348.0 6414.2 6442.1 6442.9 6449.4 6329.1 6375.8 6418.8 6498.0 6544.9 6538.7 6541.1 6581.4 6622.4 6645.8 6230.8 6346.6 6429.4 6431.0 6435.3 02:58:03 INFO - PID 7835 | 02:58:03 INFO - PID 7835 | [#1] ext.html Cycles:180 Average:38140.50 Median:3592.46 stddev:54193.46 (1508.5%) stddev-sans-first:54273.08 02:58:03 INFO - PID 7835 | Values: 831.6 874.7 874.8 877.0 880.6 39053.8 39826.4 42707.1 42964.1 42997.0 40258.8 40526.4 40587.2 40632.8 40655.4 7103.6 7248.4 7250.4 7251.5 7644.8 7748.9 7866.8 7868.2 7870.3 7875.4 7809.3 7822.9 7888.7 7891.1 7891.1 7922.6 7997.9 7998.1 8010.6 8019.0 7733.4 7789.6 7792.5 7798.3 7800.4 38923.6 39011.6 39207.2 39314.6 39348.0 3566.9 3576.0 3578.0 3578.9 3606.0 31828.5 32145.4 32184.8 32285.7 32303.0 5162.1 5167.4 5169.2 5211.2 5221.3 186249.0 186695.0 187420.0 188064.0 188635.0 42227.6 47800.3 47925.0 48042.8 48288.0 44880.8 52361.0 53044.7 53076.0 53130.5 14829.5 14955.6 14958.1 14966.3 14999.2 11842.9 11883.2 11883.8 11891.1 11897.0 14314.5 14339.1 14359.5 14432.0 14542.9 5641.3 5770.9 5775.5 5890.1 5937.4 1023.6 1031.5 1037.9 1040.1 1051.2 23153.4 23331.7 23396.8 23458.3 23875.3 1117.9 1121.0 1122.2 1133.4 1143.9 11967.2 12318.9 12366.8 12508.4 12555.4 234098.0 235440.0 235447.0 235710.0 235965.0 54432.7 54657.5 54674.0 54746.2 54810.0 1449.2 1455.1 1460.6 1481.8 1484.5 23014.0 23126.7 23270.1 23392.6 23445.8 38072.6 38131.0 38145.6 38184.2 38217.8 201181.0 201375.0 201522.0 201744.0 202100.0 34190.3 34882.0 36642.0 36860.8 36875.4 46292.8 47284.0 47296.8 47358.3 47518.0 34047.3 34177.8 34278.8 34613.0 34655.8 33638.7 33730.3 33864.0 34082.3 34623.8 37870.8 38024.4 38091.0 38096.4 38690.4 32145.2 32440.7 32583.0 33026.8 33167.8 23603.5 23847.8 23850.5 24558.8 24611.8 02:58:03 INFO - PID 7835 | 02:58:03 INFO - PID 7835 | [#2] jquery.html Cycles:180 Average:33499.43 Median:22392.55 stddev:79895.89 (356.8%) stddev-sans-first:80081.74 02:58:03 INFO - PID 7835 | Values: 561.3 566.9 567.5 569.0 591.1 22069.9 22929.7 22935.2 22980.2 22993.8 23257.4 24280.2 24375.1 24564.5 24917.8 6585.8 6784.9 6787.4 6788.6 6788.6 6422.7 6649.3 6741.4 6772.4 6772.6 6692.9 6704.8 6707.2 6719.6 6719.7 6397.4 6711.2 6711.5 6713.4 6716.0 6235.4 6237.5 6240.1 6257.3 6257.6 28388.3 28814.6 28834.0 28898.7 29008.9 2063.0 2092.0 2094.3 2095.1 2098.4 19039.6 19410.0 19637.6 19728.1 19887.9 2268.4 2324.6 2332.4 2429.4 2497.1 117209.4 122347.0 133241.0 136915.0 143353.0 13978.2 14310.4 14470.3 14663.0 14691.9 22390.8 22394.3 22406.2 22454.0 22461.2 9956.6 10220.2 10272.8 10331.4 10483.2 9656.3 9657.6 9660.3 9773.8 9834.9 8898.6 8898.6 8911.9 9032.2 9221.8 2536.3 2563.1 2628.2 2679.5 2705.5 931.7 951.4 963.2 968.6 972.9 18380.2 18578.8 19020.9 19090.1 19172.9 1012.4 1020.2 1032.4 1033.7 1035.5 10249.7 10475.5 10591.7 10688.2 10739.2 462701.0 468259.0 473912.0 484428.0 491057.0 103161.5 104155.0 105978.5 106064.5 107274.0 1015.4 1152.4 1172.9 1178.4 1181.3 19508.8 19688.6 19738.4 19831.2 20300.4 52831.7 54148.0 54404.7 54425.5 55411.4 65118.0 66419.0 67815.3 68243.7 68601.3 13130.0 13263.7 13342.3 14088.5 14090.2 22047.6 22085.3 22102.7 22365.6 22388.3 17250.7 17386.7 17502.6 17652.8 17730.5 14891.2 15219.1 15775.4 15916.5 16358.5 17066.2 17868.1 17938.5 17978.6 18030.6 13930.2 13977.7 14011.0 14018.4 14018.6 17509.5 17555.2 17589.0 17627.7 17679.0 02:58:03 INFO - PID 7835 | 02:58:03 INFO - PID 7835 | [#3] mootools.html Cycles:180 Average:9330.29 Median:2693.77 stddev:6703.96 (248.9%) stddev-sans-first:6695.80 02:58:03 INFO - PID 7835 | Values: 1328.2 1386.3 1386.7 1390.0 1390.3 14874.0 16051.8 16204.5 16223.8 16225.7 15878.5 16159.3 16160.2 16172.8 16172.8 2773.3 2838.4 2842.8 2845.4 2846.1 2679.7 2729.9 2782.1 2783.0 2790.1 2648.2 2672.3 2721.3 2740.9 2743.3 2800.9 2808.3 2828.8 2834.2 2843.7 2667.9 2682.0 2686.3 2693.4 2694.1 14367.7 14590.1 14600.8 14606.9 14608.3 7797.8 8120.5 8122.8 8133.3 8140.2 5340.9 5424.0 5489.8 5511.8 5581.4 1952.3 1955.0 1963.7 2012.1 2016.7 26831.7 26884.9 27047.3 27065.7 27090.7 6390.8 6558.8 6621.5 6730.8 6788.6 17625.2 17646.8 17653.3 17653.6 17672.4 7699.6 7825.4 7826.1 7829.8 7862.9 7033.3 7132.0 7200.2 7262.2 7274.3 5195.9 5330.3 5367.7 5388.7 5421.1 1375.0 1396.0 1507.1 1520.4 1526.6 878.2 917.6 928.6 934.3 934.4 8683.9 8719.6 8728.6 8733.7 8755.4 975.1 978.8 995.9 1001.0 1022.7 4537.0 4556.1 4675.0 5205.6 5221.8 20474.0 20712.3 21249.2 21447.8 21475.4 20796.2 21560.7 21645.0 21747.0 21810.6 11291.3 11459.8 11464.5 11508.7 11514.2 8428.2 8511.4 8521.4 8588.4 8618.7 18382.0 18629.5 18802.0 18974.8 19019.1 18314.9 18824.4 18951.6 19027.6 19170.0 10147.2 10293.5 10360.9 10362.1 10373.4 13441.3 13622.5 13625.5 13635.9 13660.0 11309.5 11368.6 11407.3 11498.4 11752.9 10856.9 10951.0 10966.6 11076.1 11336.1 9230.8 9358.8 9380.0 9387.4 9388.7 7156.2 7170.9 7230.2 7239.2 7276.1 6838.0 6935.5 6974.9 6988.7 6993.0 02:58:03 INFO - PID 7835 | 02:58:03 INFO - PID 7835 | [#4] prototype.html Cycles:180 Average:5620.65 Median:6229.44 stddev:1513.00 (24.3%) stddev-sans-first:1467.52 02:58:03 INFO - PID 7835 | Values: 495.2 517.2 528.5 528.9 537.1 6008.2 6190.4 6270.3 6299.9 6382.8 6189.3 6223.1 6245.0 6258.6 6278.7 5156.4 5191.1 5228.5 5244.0 5255.4 4935.3 5075.8 5157.6 5228.8 5229.7 5244.7 5247.8 5272.6 5279.8 5284.7 5213.9 5215.2 5265.6 5299.4 5305.6 4822.3 4872.4 4878.0 4881.9 4894.6 6216.2 6235.8 6292.2 6323.0 6333.2 5981.8 6031.6 6044.3 6054.9 6080.7 6516.4 6525.9 6551.3 6602.9 6736.4 5237.0 5238.9 5243.4 5313.4 5336.3 6955.7 6962.4 7010.8 7021.8 7071.5 5356.9 5464.9 5468.9 5482.8 5483.5 5573.4 5574.6 5575.4 5598.7 5603.2 5988.7 5990.7 6028.5 6062.3 6078.1 6590.0 6641.7 6678.6 6682.3 6698.1 1781.9 1836.2 1843.4 1868.0 1880.4 1368.4 1391.6 1432.6 1434.8 1451.5 5733.6 5742.2 5761.9 5769.2 5804.0 6456.9 6649.6 6683.5 6739.8 6773.8 5660.9 5697.5 5712.1 5729.7 5786.3 3446.8 3501.9 3524.4 3549.4 3579.3 6443.6 6462.4 6478.4 6518.8 6533.2 6801.8 6827.7 6896.3 6916.9 6930.0 6385.9 6394.7 6411.9 6463.7 6523.2 6677.4 6751.8 6751.9 6783.0 6794.9 6740.6 6776.0 6798.0 6820.7 6839.7 6445.3 6454.8 6484.7 6507.4 6555.3 4949.8 4980.8 4984.3 5004.2 5031.4 6524.4 6665.2 6782.2 6853.8 6870.6 6031.6 6414.2 6493.9 6527.6 6539.6 6358.6 6420.3 6423.9 6489.0 6490.6 6316.1 6337.9 6358.3 6400.4 6493.2 6470.3 6577.1 6647.7 6670.7 6674.2 6372.3 6393.8 6401.4 6410.4 6423.0 02:58:03 INFO - PID 7835 | 02:58:03 INFO - PID 7835 | [#5] yui.html Cycles:180 Average:24158.78 Median:17359.65 stddev:36071.43 (207.8%) stddev-sans-first:36130.34 02:58:03 INFO - PID 7835 | Values: 899.2 901.5 903.1 906.3 932.9 19206.4 19983.6 19986.4 20058.9 20081.2 16746.6 16889.5 16891.7 16925.5 16977.7 906.5 918.7 921.2 921.2 921.5 978.4 979.9 986.6 987.3 987.4 1018.2 1025.1 1042.6 1044.7 1047.7 1039.1 1039.2 1039.5 1040.3 1040.9 731.0 747.7 753.6 756.5 756.8 19035.0 19216.4 19220.6 19222.0 19228.5 21543.6 21755.5 22503.0 22569.7 22572.0 16997.0 17054.2 17326.3 17393.0 17637.9 3741.3 3744.7 3762.7 3769.4 3778.7 100246.6 114268.0 144546.3 146009.3 147680.0 15209.3 15467.1 15550.3 15668.1 15744.7 27518.7 27829.9 27876.2 27903.4 27911.7 9037.0 9108.3 9123.3 9168.4 9217.4 4298.8 4355.6 4362.5 4373.0 4373.9 5063.2 5166.1 5167.2 5180.8 5186.2 1018.0 1040.1 1046.1 1048.0 1048.5 672.1 685.4 687.3 688.1 701.2 10689.5 11079.2 11369.5 11881.9 12571.0 660.3 663.1 667.5 671.9 676.9 5327.2 5364.0 5398.9 5404.4 5456.9 127665.4 128696.0 128966.1 130123.3 132167.3 111523.4 112693.4 113580.4 115469.0 115546.0 99498.5 100339.5 101482.0 103236.5 103574.0 9981.4 10018.3 10052.3 10092.5 10115.3 44451.6 44902.8 45238.0 46497.5 47092.5 58203.4 58221.7 58474.0 59341.4 61207.0 15673.6 15783.1 15822.2 15998.1 16164.4 15550.4 15553.7 15560.3 15694.6 15707.9 13201.5 13448.5 13493.5 13540.4 13552.1 12782.8 12901.1 12967.0 12989.9 13078.9 13498.7 13500.8 13531.5 13653.7 13687.7 10514.3 10667.5 10728.9 10838.9 11084.2 11094.8 11103.8 11121.3 11226.8 11290.9 02:58:03 INFO - PID 7835 | -------- Summary: end -------- 02:58:03 INFO - PID 7835 | 02:58:04 INFO - TEST-INFO | 7835: exit 0 02:58:04 INFO - TEST-OK | dromaeo_css | took 1109062ms 02:58:04 INFO - TEST-START | kraken 02:58:04 INFO - Initialising browser for kraken test... 02:58:04 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:44967/getInfo.html -profile /tmp/tmpiRZ6k1/profile 02:58:04 INFO - TEST-INFO | started process 8214 (/builds/slave/test/build/application/firefox/firefox http://localhost:44967/getInfo.html) 02:58:09 INFO - TEST-INFO | 8214: exit 0 02:58:09 INFO - Browser initialized. 02:58:09 INFO - Running cycle 1/1 for kraken test... 02:58:09 INFO - Using env: {'DISPLAY': ':0', 02:58:09 INFO - 'HOME': '/home/cltbld', 02:58:09 INFO - 'JSGC_DISABLE_POISONING': '1', 02:58:09 INFO - 'LANG': 'en_US.UTF-8', 02:58:09 INFO - 'LANGUAGE': 'en_US:en', 02:58:09 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 02:58:09 INFO - 'LOGNAME': 'cltbld', 02:58:09 INFO - 'MAIL': '/var/mail/cltbld', 02:58:09 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:58:09 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:58:09 INFO - 'MOZ_CRASHREPORTER': '1', 02:58:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:58:09 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 02:58:09 INFO - 'MOZ_NO_REMOTE': '1', 02:58:09 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:58:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:58:09 INFO - 'NO_EM_RESTART': '1', 02:58:09 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:58:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:58:09 INFO - 'PWD': '/builds/slave/test', 02:58:09 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:58:09 INFO - 'RUST_BACKTRACE': 'full', 02:58:09 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 02:58:09 INFO - 'SHELL': '/bin/bash', 02:58:09 INFO - 'SHLVL': '1', 02:58:09 INFO - 'STYLO_FORCE_DISABLED': '1', 02:58:09 INFO - 'TERM': 'linux', 02:58:09 INFO - 'TMOUT': '86400', 02:58:09 INFO - 'USER': 'cltbld', 02:58:09 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1504863418.753420-1283253239', 02:58:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:58:09 INFO - '_': '/tools/buildbot/bin/python'} 02:58:09 INFO - TEST-INFO | started process 8410 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpiRZ6k1/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 02:58:10 INFO - PID 8410 | 02:58:10 INFO - PID 8410 | (/builds/slave/test/build/application/firefox/firefox:8461): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 02:58:10 INFO - PID 8410 | 02:58:21 INFO - PID 8410 | RSS: Main: 169615360 02:58:21 INFO - PID 8410 | 02:58:23 INFO - PID 8410 | Cycle 1(1): loaded http://localhost:44967/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44967/tests/kraken/driver.html?testName=audio-beat-detection) 02:58:24 INFO - PID 8410 | RSS: Main: 175546368 02:58:24 INFO - PID 8410 | 02:58:27 INFO - PID 8410 | Cycle 1(1): loaded http://localhost:44967/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44967/tests/kraken/driver.html?testName=audio-dft) 02:58:27 INFO - PID 8410 | RSS: Main: 176304128 02:58:27 INFO - PID 8410 | 02:58:30 INFO - PID 8410 | Cycle 1(1): loaded http://localhost:44967/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44967/tests/kraken/driver.html?testName=audio-fft) 02:58:31 INFO - PID 8410 | RSS: Main: 170467328 02:58:31 INFO - PID 8410 | 02:58:33 INFO - PID 8410 | Cycle 1(1): loaded http://localhost:44967/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44967/tests/kraken/driver.html?testName=audio-oscillator) 02:58:34 INFO - PID 8410 | RSS: Main: 171896832 02:58:34 INFO - PID 8410 | 02:58:36 INFO - PID 8410 | Cycle 1(1): loaded http://localhost:44967/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44967/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:58:36 INFO - PID 8410 | RSS: Main: 171773952 02:58:36 INFO - PID 8410 | 02:58:39 INFO - PID 8410 | Cycle 1(1): loaded http://localhost:44967/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44967/tests/kraken/driver.html?testName=imaging-darkroom) 02:58:40 INFO - PID 8410 | RSS: Main: 174637056 02:58:40 INFO - PID 8410 | 02:58:44 INFO - PID 8410 | Cycle 1(1): loaded http://localhost:44967/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44967/tests/kraken/driver.html?testName=imaging-desaturate) 02:58:44 INFO - PID 8410 | RSS: Main: 173981696 02:58:44 INFO - PID 8410 | 02:58:47 INFO - PID 8410 | Cycle 1(1): loaded http://localhost:44967/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44967/tests/kraken/driver.html?testName=json-parse-financial) 02:58:48 INFO - PID 8410 | RSS: Main: 174571520 02:58:48 INFO - PID 8410 | 02:58:49 INFO - PID 8410 | Cycle 1(1): loaded http://localhost:44967/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44967/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:58:50 INFO - PID 8410 | RSS: Main: 174444544 02:58:50 INFO - PID 8410 | 02:58:52 INFO - PID 8410 | Cycle 1(1): loaded http://localhost:44967/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44967/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:58:52 INFO - PID 8410 | RSS: Main: 174657536 02:58:52 INFO - PID 8410 | 02:58:54 INFO - PID 8410 | Cycle 1(1): loaded http://localhost:44967/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44967/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:58:55 INFO - PID 8410 | RSS: Main: 171819008 02:58:55 INFO - PID 8410 | 02:58:58 INFO - PID 8410 | Cycle 1(1): loaded http://localhost:44967/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44967/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:58:58 INFO - PID 8410 | RSS: Main: 172273664 02:58:58 INFO - PID 8410 | 02:59:01 INFO - PID 8410 | Cycle 1(1): loaded http://localhost:44967/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44967/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:59:02 INFO - PID 8410 | RSS: Main: 172630016 02:59:02 INFO - PID 8410 | 02:59:04 INFO - PID 8410 | Cycle 1(1): loaded http://localhost:44967/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44967/tests/kraken/driver.html?testName=ai-astar) 02:59:04 INFO - PID 8410 | RSS: Main: 173871104 02:59:04 INFO - PID 8410 | 02:59:04 INFO - PID 8410 | __start_tp_report 02:59:04 INFO - PID 8410 | _x_x_mozilla_page_load 02:59:04 INFO - PID 8410 | _x_x_mozilla_page_load_details 02:59:04 INFO - PID 8410 | |i|pagename|runs| 02:59:04 INFO - PID 8410 | |0;ai-astar;110;107;107;107;109;107;113;107;108;99 02:59:04 INFO - PID 8410 | |1;audio-beat-detection;121;115;123;119;116;117;118;117;115;118 02:59:04 INFO - PID 8410 | |2;audio-dft;165;166;162;163;162;164;162;163;173;165 02:59:04 INFO - PID 8410 | |3;audio-fft;73;72;75;74;75;73;75;74;79;74 02:59:04 INFO - PID 8410 | |4;audio-oscillator;83;80;83;78;78;78;79;80;88;79 02:59:04 INFO - PID 8410 | |5;imaging-gaussian-blur;114;114;113;118;110;113;114;113;115;115 02:59:04 INFO - PID 8410 | |6;imaging-darkroom;147;148;147;147;148;148;148;148;151;148 02:59:04 INFO - PID 8410 | |7;imaging-desaturate;94;99;94;94;94;95;94;93;94;93 02:59:04 INFO - PID 8410 | |8;json-parse-financial;55;53;63;52;52;53;52;55;53;53 02:59:04 INFO - PID 8410 | |9;json-stringify-tinderbox;38;38;37;37;46;38;38;38;38;38 02:59:04 INFO - PID 8410 | |10;stanford-crypto-aes;80;78;75;74;74;76;77;76;76;80 02:59:04 INFO - PID 8410 | |11;stanford-crypto-ccm;128;120;116;119;130;123;124;117;123;133 02:59:04 INFO - PID 8410 | |12;stanford-crypto-pbkdf2;171;181;168;167;179;167;166;168;174;167 02:59:04 INFO - PID 8410 | |13;stanford-crypto-sha256-iterative;63;66;61;66;62;63;64;61;61;62 02:59:04 INFO - PID 8410 | __end_tp_report 02:59:04 INFO - PID 8410 | __start_cc_report 02:59:04 INFO - PID 8410 | _x_x_mozilla_cycle_collect,941 02:59:04 INFO - PID 8410 | __end_cc_report 02:59:04 INFO - PID 8410 | __startTimestamp1504864744364__endTimestamp 02:59:04 INFO - PID 8410 | 02:59:04 INFO - PID 8410 | ------- Summary: start ------- 02:59:04 INFO - PID 8410 | Number of tests: 14 02:59:04 INFO - PID 8410 | 02:59:04 INFO - PID 8410 | [#0] ai-astar Cycles:10 Average:107.40 Median:108.50 stddev:3.53 (3.3%) stddev-sans-first:3.62 02:59:04 INFO - PID 8410 | Values: 110.0 107.0 107.0 107.0 109.0 107.0 113.0 107.0 108.0 99.0 02:59:04 INFO - PID 8410 | 02:59:04 INFO - PID 8410 | [#1] audio-beat-detection Cycles:10 Average:117.90 Median:118.00 stddev:2.56 (2.2%) stddev-sans-first:2.46 02:59:04 INFO - PID 8410 | Values: 121.0 115.0 123.0 119.0 116.0 117.0 118.0 117.0 115.0 118.0 02:59:04 INFO - PID 8410 | 02:59:04 INFO - PID 8410 | [#2] audio-dft Cycles:10 Average:164.50 Median:164.50 stddev:3.31 (2.0%) stddev-sans-first:3.50 02:59:04 INFO - PID 8410 | Values: 165.0 166.0 162.0 163.0 162.0 164.0 162.0 163.0 173.0 165.0 02:59:04 INFO - PID 8410 | 02:59:04 INFO - PID 8410 | [#3] audio-fft Cycles:10 Average:74.40 Median:74.50 stddev:1.90 (2.5%) stddev-sans-first:1.94 02:59:04 INFO - PID 8410 | Values: 73.0 72.0 75.0 74.0 75.0 73.0 75.0 74.0 79.0 74.0 02:59:04 INFO - PID 8410 | 02:59:04 INFO - PID 8410 | [#4] audio-oscillator Cycles:10 Average:80.60 Median:80.00 stddev:3.20 (4.0%) stddev-sans-first:3.28 02:59:04 INFO - PID 8410 | Values: 83.0 80.0 83.0 78.0 78.0 78.0 79.0 80.0 88.0 79.0 02:59:04 INFO - PID 8410 | 02:59:04 INFO - PID 8410 | [#5] imaging-gaussian-blur Cycles:10 Average:113.90 Median:114.00 stddev:2.02 (1.8%) stddev-sans-first:2.15 02:59:04 INFO - PID 8410 | Values: 114.0 114.0 113.0 118.0 110.0 113.0 114.0 113.0 115.0 115.0 02:59:04 INFO - PID 8410 | 02:59:04 INFO - PID 8410 | [#6] imaging-darkroom Cycles:10 Average:148.00 Median:148.00 stddev:1.15 (0.8%) stddev-sans-first:1.17 02:59:04 INFO - PID 8410 | Values: 147.0 148.0 147.0 147.0 148.0 148.0 148.0 148.0 151.0 148.0 02:59:04 INFO - PID 8410 | 02:59:04 INFO - PID 8410 | [#7] imaging-desaturate Cycles:10 Average:94.40 Median:94.00 stddev:1.71 (1.8%) stddev-sans-first:1.81 02:59:04 INFO - PID 8410 | Values: 94.0 99.0 94.0 94.0 94.0 95.0 94.0 93.0 94.0 93.0 02:59:04 INFO - PID 8410 | 02:59:04 INFO - PID 8410 | [#8] json-parse-financial Cycles:10 Average:54.10 Median:53.00 stddev:3.31 (6.3%) stddev-sans-first:3.50 02:59:04 INFO - PID 8410 | Values: 55.0 53.0 63.0 52.0 52.0 53.0 52.0 55.0 53.0 53.0 02:59:04 INFO - PID 8410 | 02:59:04 INFO - PID 8410 | [#9] json-stringify-tinderbox Cycles:10 Average:38.60 Median:38.00 stddev:2.63 (6.9%) stddev-sans-first:2.78 02:59:04 INFO - PID 8410 | Values: 38.0 38.0 37.0 37.0 46.0 38.0 38.0 38.0 38.0 38.0 02:59:04 INFO - PID 8410 | 02:59:04 INFO - PID 8410 | [#10] stanford-crypto-aes Cycles:10 Average:76.60 Median:76.50 stddev:2.17 (2.8%) stddev-sans-first:1.92 02:59:04 INFO - PID 8410 | Values: 80.0 78.0 75.0 74.0 74.0 76.0 77.0 76.0 76.0 80.0 02:59:04 INFO - PID 8410 | 02:59:04 INFO - PID 8410 | [#11] stanford-crypto-ccm Cycles:10 Average:123.30 Median:123.50 stddev:5.62 (4.5%) stddev-sans-first:5.70 02:59:04 INFO - PID 8410 | Values: 128.0 120.0 116.0 119.0 130.0 123.0 124.0 117.0 123.0 133.0 02:59:04 INFO - PID 8410 | 02:59:04 INFO - PID 8410 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:170.80 Median:169.50 stddev:5.41 (3.2%) stddev-sans-first:5.74 02:59:04 INFO - PID 8410 | Values: 171.0 181.0 168.0 167.0 179.0 167.0 166.0 168.0 174.0 167.0 02:59:04 INFO - PID 8410 | 02:59:04 INFO - PID 8410 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.90 Median:63.00 stddev:1.91 (3.0%) stddev-sans-first:2.03 02:59:04 INFO - PID 8410 | Values: 63.0 66.0 61.0 66.0 62.0 63.0 64.0 61.0 61.0 62.0 02:59:04 INFO - PID 8410 | -------- Summary: end -------- 02:59:04 INFO - PID 8410 | 02:59:04 INFO - PID 8410 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 02:59:05 INFO - TEST-INFO | 8410: exit 0 02:59:05 INFO - TEST-OK | kraken | took 60971ms 02:59:05 INFO - SUITE-END | took 1170s 02:59:05 INFO - Completed test suite (00:19:30) 02:59:05 INFO - javascript benchmark 02:59:05 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s", "stylo_disabled"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8490.120300741431, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3045.451818672639, 3087.459694553453, 3115.8753649853993, 3123.9219019524508, 3148.511980643001, 6070.484008859241, 6220.595661282025, 6255.718492667829, 6296.370362963696, 6326.430621244087, 6164.691765411722, 6238.376162383759, 6258.655773932432, 6286.874262514747, 6287.559870809046, 5764.279465066867, 5778.191053252537, 5792.71036448178, 5794.188813566104, 5811.6803575803315, 5746.109353050263, 5801.593888427812, 5808.390119037483, 5886.705664716768, 5901.498372638331, 5815.709214539256, 5845.0, 5907.970460147715, 5922.0, 5940.316863560703, 5596.664200148004, 5831.0, 5832.912506312408, 5873.324567674708, 5903.881922361572, 5321.414644389114, 5622.3253209614695, 5661.716914154317, 5664.518515926151, 5721.399253078408, 6213.409726076015, 6240.0, 6307.400796924331, 6317.305096439388, 6344.302126766052, 6660.433863121641, 6666.466682665375, 6673.5662181958505, 6749.898751518731, 6751.831204219885, 6714.362135597111, 6725.461963042945, 6770.255271920085, 6771.8984215236815, 6779.2881747416795, 6257.624542527417, 6339.619622822645, 6344.397282258178, 6345.270293916213, 6347.1114044033875, 6900.758473453405, 6910.896336554855, 7006.50954433195, 7012.7545535906, 7026.051483049825, 6424.935750642528, 6534.9673251634385, 6552.180977377828, 6553.475721942234, 6595.274519802818, 6579.276279609239, 6642.269350371455, 6652.8669426611195, 6652.966735166293, 6661.367170118831, 6621.801345959629, 6678.666066696743, 6756.729730810811, 6761.290064543152, 6795.456363490909, 6696.698648560827, 6769.39075483199, 6799.32006799326, 6801.1838579369805, 6806.285340039323, 5239.633225674243, 5280.392754833243, 5319.654222475527, 5326.201069839555, 5329.706866122323, 4557.863264102082, 4563.954360456353, 4573.611243044312, 4585.816567337336, 4651.930221046687, 5728.083506638918, 5741.110127930177, 5743.10981797822, 5743.195952566644, 5744.942550574524, 6644.867102658017, 6690.565113267622, 6780.627065511444, 6782.593044417351, 6783.660816959133, 5775.768969241183, 5824.301083869963, 5852.239208902815, 5852.941470585325, 5853.560982926212, 5769.336526299446, 5775.27809023872, 5846.912296315559, 5856.619319744203, 5859.414058594107, 6286.811395658137, 6381.840453988594, 6391.424771770563, 6466.902996455057, 6549.0, 6677.465802735769, 6707.29573394806, 6713.832154196184, 6714.127163468718, 6715.227748808852, 6356.618602883842, 6419.839504012437, 6441.935580644321, 6442.484601231984, 6451.225852897683, 6613.503987200883, 6630.038644396439, 6651.866962660816, 6669.7332106715185, 6744.966275168593, 6739.157605299338, 6759.053732477555, 6833.350831670983, 6834.077399550997, 6837.897431538431, 6357.682115894094, 6476.0, 6479.676016199265, 6490.156279683611, 6500.057491663777, 6347.96826015867, 6414.198225221848, 6442.065900444503, 6442.903356449563, 6449.419552240321, 6329.082283069021, 6375.840603984752, 6418.775342863164, 6498.0252962056065, 6544.869102618016, 6538.705758240795, 6541.051547525677, 6581.407673309425, 6622.37087476689, 6645.767398141042, 6230.7507699693315, 6346.587471814318, 6429.35706429372, 6430.967845160744, 6435.292117866938], "value": 6108.967993166688, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [831.567584855875, 874.6719980007497, 874.8250349930014, 876.9561521923906, 880.5685214245018, 39053.80473097634, 39826.40260396093, 42707.145857082876, 42964.14071718564, 42997.0, 40258.7987060065, 40526.39210411846, 40587.188256234855, 40632.796836015776, 40655.39016914749, 7103.573785572869, 7248.420126389876, 7250.383717384028, 7251.456140789435, 7644.808879778022, 7748.883766743504, 7866.803329916741, 7868.213178682143, 7870.252326029018, 7875.369970402354, 7809.258120478546, 7822.921770782276, 7888.723894663688, 7891.053073631172, 7891.092524359715, 7922.603869806516, 7997.880031799469, 7998.12020677725, 8010.5594192319395, 8019.0, 7733.381329493684, 7789.649465774054, 7792.532448053135, 7798.298153166243, 7800.4149688773, 38923.610763892284, 39011.609883901365, 39207.21585568301, 39314.60685393138, 39348.0, 3566.857325706969, 3575.982120089383, 3577.9821100894587, 3578.8926332210076, 3606.026372879308, 31828.522572161437, 32145.357092858245, 32184.83907580447, 32285.677143228735, 32303.0, 5162.096633089232, 5167.431582525919, 5169.172932330809, 5211.166213405875, 5221.321228240343, 186249.0, 186695.0, 187420.0, 188064.0, 188634.99999999863, 42227.57772422236, 47800.28299575509, 47925.04149916982, 48042.75978620085, 48288.0, 44880.77559612181, 52361.0, 53044.734776326644, 53076.0, 53130.46869531255, 14829.480968166063, 14955.551333460013, 14958.102513849204, 14966.251687415586, 14999.175045372609, 11842.940785296018, 11883.227590206609, 11883.821742673867, 11891.108166887345, 11897.0, 14314.498992535211, 14339.139651620937, 14359.497417590333, 14432.0, 14542.854571454362, 5641.294838145232, 5770.88458230833, 5775.451332123442, 5890.14592884038, 5937.4359435854385, 1023.559869256227, 1031.5409642709074, 1037.8806437259661, 1040.1159014837478, 1051.1643243621186, 23153.421164470685, 23331.650025249633, 23396.766032339798, 23458.320421444176, 23875.283741487783, 1117.9049780768726, 1121.0471099565304, 1122.2368789223406, 1133.4276190523897, 1143.8684551276542, 11967.22213056166, 12318.876811231952, 12366.814497782541, 12508.437120329607, 12555.435005424777, 234098.0, 235440.0, 235447.0, 235710.0, 235965.0, 54432.727836360566, 54657.45342546603, 54674.0, 54746.17880731792, 54810.0, 1449.154332480227, 1455.097839339595, 1460.5545308680742, 1481.8444063373406, 1484.5249520153448, 23014.0, 23126.653100203846, 23270.069197231922, 23392.64911026302, 23445.76554234504, 38072.61927380691, 38131.0, 38145.61854381532, 38184.236315274095, 38217.80891095527, 201181.0, 201375.0, 201522.0, 201744.0, 202100.0, 34190.31619367649, 34882.0, 36642.0, 36860.81569592135, 36875.44686829646, 46292.768536157106, 47284.0, 47296.763516182196, 47358.28962565495, 47518.0, 34047.319053618296, 34177.82911085528, 34278.82860585681, 34613.0, 34655.82672086624, 33638.66361336453, 33730.32539349249, 33864.0, 34082.31835363329, 34623.82688086543, 37870.81064594659, 38024.429633554966, 38091.0, 38096.428553572274, 38690.41964370593, 32145.196370090936, 32440.675593243766, 32583.0, 33026.83486582552, 33167.83416082904, 23603.52792944097, 23847.761522384553, 23850.52298954046, 24558.754412455648, 24611.753882461664], "value": 17375.191103338166, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [561.278756797515, 566.9291338582677, 567.4609121334734, 568.9743961521731, 591.1310373750588, 22069.889650551766, 22929.656055159187, 22935.19726809562, 22980.195693150745, 22993.770062299373, 23257.418564535896, 24280.150194743186, 24375.14686985956, 24564.508709825794, 24917.75082249177, 6585.769498067557, 6784.9321506785045, 6787.389134977851, 6788.626625535593, 6788.626625535593, 6422.743090276406, 6649.335066493336, 6741.359570840762, 6772.424343930772, 6772.627505487197, 6692.93307066928, 6704.83237919051, 6707.1616047994, 6719.63042032688, 6719.7312107515645, 6397.4242318191355, 6711.228208756007, 6711.463082953352, 6713.362230588086, 6716.0, 6235.407636274546, 6237.469815065725, 6240.063990401431, 6257.342978987232, 6257.56197066201, 28388.29029274264, 28814.567781483296, 28834.0, 28898.711012890024, 29008.854955725088, 2063.0, 2092.0, 2094.2565389286888, 2095.057224249079, 2098.3914664747203, 19039.61920761577, 19410.0, 19637.607247855107, 19728.11223494932, 19887.900560497248, 2268.4215525041172, 2324.6164382876805, 2332.428555004018, 2429.4047958250344, 2497.1384872219055, 117209.41395293054, 122347.0, 133241.0, 136915.0, 143352.99999999895, 13978.231197284043, 14310.427582896567, 14470.302051428524, 14663.0, 14691.89810764197, 22390.776092239194, 22394.32817015492, 22406.215782447536, 22454.0, 22461.213857514907, 9956.551955162035, 10220.182385409149, 10272.794544109076, 10331.380117192992, 10483.161347092368, 9656.275779316438, 9657.565409556586, 9660.275479339078, 9773.804523909483, 9834.901650983542, 8898.59956301955, 8898.644054237888, 8911.866322005175, 9032.187103160748, 9221.769455763659, 2536.3151948973673, 2563.115725074846, 2628.172125780373, 2679.4641071785722, 2705.4578890032494, 931.6925414613297, 951.3768481644533, 963.1861077389594, 968.6367612145445, 972.8832540095234, 18380.17289221988, 18578.814211857978, 19020.904895475433, 19090.14094365757, 19172.90413547923, 1012.4026824173773, 1020.2348238820884, 1032.4166845732138, 1033.6537260017828, 1035.4615599888016, 10249.692509224735, 10475.47622618866, 10591.682249532527, 10688.198385121146, 10739.248252622241, 462701.0, 468259.0, 473912.0, 484428.0, 491057.0, 103161.48419258006, 104155.0, 105978.47010765052, 106064.46967765265, 107274.0, 1015.4364327797995, 1152.3719572832827, 1172.865120511135, 1178.3519064514483, 1181.2794195540714, 19508.804911950698, 19688.606227875647, 19738.40784776459, 19831.206751730348, 20300.390988270374, 52831.735841320544, 54148.0, 54404.72797635986, 54425.455745442036, 55411.44588554063, 65118.0, 66419.0, 67815.3218467809, 68243.65878170577, 68601.31398685949, 13130.0, 13263.734725305632, 13342.26617536006, 14088.506902258372, 14090.154590724589, 22047.559048819254, 22085.33743987683, 22102.668459973436, 22365.552688946456, 22388.32835014952, 17250.65498690044, 17386.652266954337, 17502.562435939202, 17652.823471765118, 17730.468085957444, 14891.180985045927, 15219.086854788748, 15775.447859324868, 15916.522504324888, 16358.509244722678, 17066.232019559397, 17868.106594670473, 17938.461846144637, 17978.5505362367, 18030.63938721192, 13930.164190148624, 13977.708479431787, 14011.0, 14018.369173387018, 14018.579442616738, 17509.474715758548, 17555.210015549077, 17589.0, 17627.735583965994, 17679.0], "value": 11738.671350257671, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1328.1765305510585, 1386.299918541138, 1386.7434524612947, 1390.0339264211375, 1390.2909516146763, 14873.999999999987, 16051.83948160518, 16204.513864584067, 16223.756643650355, 16225.675486490292, 15878.52364429066, 16159.272832722527, 16160.191990400492, 16172.75740863888, 16172.83827161731, 2773.320536468568, 2838.4323135372906, 2842.815217010888, 2845.3597940463437, 2846.131929761422, 2679.6918354389204, 2729.890804367823, 2782.0819129687256, 2783.025940920682, 2790.1071657069747, 2648.2055383385004, 2672.345275407528, 2721.306066952934, 2740.931476713088, 2743.3278846682592, 2800.9299767505872, 2808.255812209766, 2828.8302701837956, 2834.1922552072665, 2843.7298456646586, 2667.9333016674736, 2681.9597706034424, 2686.288133644566, 2693.420914503391, 2694.124409566879, 14367.712645747131, 14590.051646642934, 14600.780988285183, 14606.926965365212, 14608.269586520737, 7797.805054873674, 8120.472169309035, 8122.796930076736, 8133.349332053422, 8140.226678465596, 5340.946590534084, 5424.0, 5489.780408783644, 5511.751971161308, 5581.358143813472, 1952.3362056900721, 1955.0, 1963.7054441833695, 2012.0845015517905, 2016.7378240828598, 26831.73168268312, 26884.865575672193, 27047.323816904536, 27065.729342706516, 27090.729092709018, 6390.7763228286785, 6558.80323590293, 6621.5364924454825, 6730.798076057726, 6788.558743681645, 17625.206865691074, 17646.823531764774, 17653.293868245382, 17653.646927061385, 17672.38146664886, 7699.576523291273, 7825.413094017971, 7826.060872695313, 7829.804254893673, 7862.921370786334, 7033.261507541737, 7131.964340178266, 7200.243974382719, 7262.237465066092, 7274.30894065063, 5195.896082078338, 5330.333708286465, 5367.731613419392, 5388.676679399248, 5421.105517589633, 1374.9518766843112, 1395.9790603140962, 1507.0580886945659, 1520.4146403634459, 1526.625976635709, 878.1964502480287, 917.605429665237, 928.6053427293373, 934.2992755433424, 934.4393363981557, 8683.86974195375, 8719.60761765722, 8728.563571821383, 8733.694320698745, 8755.430896991675, 975.0931633580838, 978.7993461340408, 995.9203263738883, 1001.0390025575383, 1022.6880801355509, 4537.0, 4556.134334476439, 4674.97662511692, 5205.609579281569, 5221.817236396784, 20474.0, 20712.275070372463, 21249.150033998467, 21447.78552214489, 21475.355739327846, 20796.168153274004, 21560.676589851166, 21645.0, 21747.0, 21810.563788724136, 11291.322520648788, 11459.77080458386, 11464.4840982156, 11508.654740357802, 11514.19400641947, 8428.241458268785, 8511.404201705822, 8521.44610600309, 8588.441751286146, 8618.65525379003, 18382.0, 18629.534261643566, 18802.0, 18974.810251897303, 19019.144138513522, 18314.908425457787, 18824.435266942015, 18951.620967580846, 19027.619447611247, 19170.0, 10147.188224942134, 10293.53679084458, 10360.948195258976, 10362.119219866396, 10373.429461379697, 13441.327933603085, 13622.523211687543, 13625.523106691218, 13635.931820341231, 13660.0, 11309.547618095185, 11368.602098926498, 11407.25852819564, 11498.425078746197, 11752.941235293769, 10856.891431085589, 10951.0, 10966.561337546409, 11076.113910886948, 11336.149788765711, 9230.769230769285, 9358.812823743623, 9380.0, 9387.389819661701, 9388.718338449857, 7156.248593897774, 7170.892436613351, 7230.168530619047, 7239.239879812544, 7276.090488688914, 6838.0, 6935.549189302679, 6974.895376569254, 6988.685509152202, 6992.965035174995], "value": 6682.624373796758, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [495.23486213799674, 517.2035065998363, 528.493792690831, 528.9444608316127, 537.073548129477, 6008.24896887889, 6190.442860142592, 6270.31026587075, 6299.905501417483, 6382.808515744529, 6189.29794306566, 6223.097650840626, 6245.0, 6258.593191442553, 6278.717457714402, 5156.432792392834, 5191.117510023286, 5228.47715228478, 5243.973780131094, 5255.421903590602, 4935.259711043336, 5075.847724568251, 5157.575939308519, 5228.777769447988, 5229.7385130743505, 5244.737763111848, 5247.816326428576, 5272.604554658396, 5279.815206467774, 5284.656497327681, 5213.905079933237, 5215.191645294966, 5265.605079619006, 5299.417064122943, 5305.602079844027, 4822.252550854623, 4872.366592343008, 4877.975610121962, 4881.902361952741, 4894.632902532288, 6216.222972128484, 6235.781747638856, 6292.150559674431, 6323.024741619171, 6333.1766870306565, 5981.760729570812, 6031.6079454835735, 6044.304904935944, 6054.939450605481, 6080.695965201722, 6516.413522782972, 6525.869482610321, 6551.312112228243, 6602.93397066028, 6736.393724564764, 5236.973815130938, 5238.947610523884, 5243.370795504564, 5313.38896026958, 5336.30628018359, 6955.721771129149, 6962.408195303456, 7010.789676309719, 7021.841396169575, 7071.469639777038, 5356.892862142735, 5464.863378415572, 5468.945310546923, 5482.835514934479, 5483.479069488392, 5573.4394369576585, 5574.58190635704, 5575.4424557543925, 5598.692071936001, 5603.243562119062, 5988.700564971734, 5990.700464976734, 6028.457438830526, 6062.2725272966645, 6078.149059131725, 6589.968614437413, 6641.734330626818, 6678.565893216925, 6682.264950855402, 6698.129243198353, 1781.8930864148192, 1836.173721825184, 1843.4469659102215, 1868.0472958791115, 1880.3700760245472, 1368.3773882883265, 1391.5964370332692, 1432.5917113622568, 1434.8206474190727, 1451.4702133721328, 5733.627314224562, 5742.196092547047, 5761.8559536011935, 5769.163471296639, 5803.970980145073, 6456.903146452807, 6649.60102393858, 6683.4987375947, 6739.797806065826, 6773.762918297934, 5660.85847853807, 5697.515711164598, 5712.058289980663, 5729.713514324267, 5786.334571524329, 3446.827658617059, 3501.8949431517094, 3524.4360902255517, 3549.378858699717, 3579.3378225028455, 6443.581167224115, 6462.3537646235, 6478.384553467413, 6518.837029074311, 6533.18335208099, 6801.829954251084, 6827.658617069127, 6896.3103689631635, 6916.896246556305, 6930.0, 6385.936140638534, 6394.712237949303, 6411.871762564816, 6463.741450342028, 6523.249826269945, 6677.43241824431, 6751.797446076625, 6751.93248067513, 6783.0, 6794.898076528955, 6740.595564266159, 6775.966120169368, 6798.0, 6820.658967051529, 6839.6580170990255, 6445.291017988111, 6454.838629034311, 6484.740610375721, 6507.414332710079, 6555.2789193189665, 4949.82675606352, 4980.775865086008, 4984.302197692254, 5004.199328107486, 5031.371078615173, 6524.368907773057, 6665.166854143232, 6782.220044694726, 6853.760118395832, 6870.553414028072, 6031.60794548353, 6414.198225221848, 6493.8701225976165, 6527.575707579183, 6539.6403197824575, 6358.598149989733, 6420.26166990802, 6423.903641445476, 6488.967555162194, 6490.610563366213, 6316.147320111726, 6337.8732425352155, 6358.268799088164, 6400.39196276353, 6493.22081350241, 6470.255920569007, 6577.079208910852, 6647.734090636321, 6670.733170673118, 6674.16572928384, 6372.299047104722, 6393.808185754435, 6401.391867772741, 6410.423061924449, 6422.967885160544], "value": 5183.185212220204, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [899.1907283444899, 901.535709109809, 903.0788595632455, 906.3066753933238, 932.9393589416687, 19206.423807285788, 19983.60032799345, 19986.40040798775, 20058.89970550147, 20081.196752129934, 16746.58133546662, 16889.493315200532, 16891.746623800653, 16925.492235232963, 16977.745333820003, 906.5150144672601, 918.6968300460866, 921.1617428140394, 921.1893533690377, 921.4655499810127, 978.427619842393, 979.8775153105862, 986.6201512417699, 987.3483500889414, 987.4075554667178, 1018.2159737002504, 1025.0723095598496, 1042.598599539179, 1044.738815296176, 1047.6752206815872, 1039.1271332081087, 1039.1790485516433, 1039.469870366115, 1040.2614143957762, 1040.9479526023706, 730.9853802923965, 747.6598147842718, 753.6231884057971, 756.5120497279224, 756.7994481462362, 19035.048247587565, 19216.423507294665, 19220.615587688168, 19222.03889805518, 19228.519287017938, 21543.569128617495, 21755.456113597127, 22503.0, 22569.66145507819, 22572.0, 16997.0, 17054.232559534852, 17326.306947722074, 17393.0, 17637.911810440994, 3741.27045226181, 3744.719146064056, 3762.6801721853676, 3769.4157405602177, 3778.6599206071587, 100246.5636119358, 114268.0, 144546.277268613, 146009.26995365063, 147680.0, 15209.315580798891, 15467.149306788235, 15550.300236489385, 15668.138252396, 15744.68510629781, 27518.724812751618, 27829.860850695615, 27876.16371508858, 27903.441931161262, 27911.720882790913, 9037.0, 9108.271338293052, 9123.315751318678, 9168.404053736485, 9217.44695318283, 4298.76356800379, 4355.629771469397, 4362.541933097043, 4372.956270437255, 4373.890652733707, 5063.164577844688, 5166.147585648401, 5167.22491626259, 5180.766865491062, 5186.196139598368, 1017.9898201018043, 1040.147079394889, 1046.0742243114898, 1047.9685609431729, 1048.4652827058255, 672.1060988884772, 685.4276678973014, 687.285223367692, 688.084847153285, 701.193627328566, 10689.465526723632, 11079.224454288122, 11369.488373023234, 11881.93062624368, 12571.0, 660.313274194832, 663.0584569910739, 667.5227212542958, 671.94840075283, 676.9458443324522, 5327.200919861974, 5363.999980026026, 5398.946010539844, 5404.351477822686, 5456.863578410572, 127665.36167319104, 128696.0, 128966.06550901744, 130123.34938325248, 132167.33916330358, 111523.44238278757, 112693.4365328168, 113580.43209783899, 115469.0, 115546.0, 99498.50250748845, 100339.49151271276, 101482.0, 103236.48381758043, 103573.99999999849, 9981.401115933068, 10018.298719089886, 10052.296339256181, 10092.54583543757, 10115.342502737298, 44451.55548444474, 44902.77548612236, 45238.0, 46497.53502465067, 47092.52907471018, 58203.4179658198, 58221.70889145527, 58474.0, 59341.40658593359, 61207.0, 15673.608159796097, 15783.131927744083, 15822.208889555246, 15998.120103394425, 16164.434244801376, 15550.377984880479, 15553.688926221186, 15560.299786509408, 15694.607634809221, 15707.921460392625, 13201.537946171838, 13448.46206151743, 13493.527726529524, 13540.390682419118, 13552.119112257671, 12782.808257875953, 12901.096923215286, 12967.027472939379, 12989.935050324688, 13078.934605326913, 13498.730025399633, 13500.797488037491, 13531.458741650618, 13653.658658533615, 13687.726245475234, 10514.264001520127, 10667.51996160159, 10728.89271107279, 10838.891611084104, 11084.16868734832, 11094.833577496505, 11103.777924441627, 11121.332720036824, 11226.831597526207, 11290.887091129312], "value": 8677.5658270756, "unit": "score"}]}, {"extraOptions": ["e10s", "stylo_disabled"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1427.4, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 107.0, 107.0, 107.0, 109.0, 107.0, 113.0, 107.0, 108.0, 99.0], "value": 107.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [121.0, 115.0, 123.0, 119.0, 116.0, 117.0, 118.0, 117.0, 115.0, 118.0], "value": 117.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 166.0, 162.0, 163.0, 162.0, 164.0, 162.0, 163.0, 173.0, 165.0], "value": 164.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 72.0, 75.0, 74.0, 75.0, 73.0, 75.0, 74.0, 79.0, 74.0], "value": 74.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 80.0, 83.0, 78.0, 78.0, 78.0, 79.0, 80.0, 88.0, 79.0], "value": 80.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 113.0, 118.0, 110.0, 113.0, 114.0, 113.0, 115.0, 115.0], "value": 113.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 148.0, 147.0, 147.0, 148.0, 148.0, 148.0, 148.0, 151.0, 148.0], "value": 148.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 99.0, 94.0, 94.0, 94.0, 95.0, 94.0, 93.0, 94.0, 93.0], "value": 94.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 53.0, 63.0, 52.0, 52.0, 53.0, 52.0, 55.0, 53.0, 53.0], "value": 54.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [38.0, 38.0, 37.0, 37.0, 46.0, 38.0, 38.0, 38.0, 38.0, 38.0], "value": 38.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 78.0, 75.0, 74.0, 74.0, 76.0, 77.0, 76.0, 76.0, 80.0], "value": 76.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [128.0, 120.0, 116.0, 119.0, 130.0, 123.0, 124.0, 117.0, 123.0, 133.0], "value": 123.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 181.0, 168.0, 167.0, 179.0, 167.0, 166.0, 168.0, 174.0, 167.0], "value": 170.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 66.0, 61.0, 66.0, 62.0, 63.0, 64.0, 61.0, 61.0, 62.0], "value": 62.9, "unit": "score"}]}]} 02:59:05 INFO - Return code: 0 02:59:05 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 02:59:05 INFO - # TBPL SUCCESS # 02:59:05 INFO - Running post-action listener: _package_coverage_data 02:59:05 INFO - Running post-action listener: _resource_record_post_action 02:59:05 INFO - [mozharness: 2017-09-08 09:59:05.683088Z] Finished run-tests step (success) 02:59:05 INFO - Running post-run listener: _resource_record_post_run 02:59:05 INFO - Total resource usage - Wall time: 1187s; CPU: 13.0%; Read bytes: 438272; Write bytes: 403136512; Read time: 400; Write time: 239072 02:59:05 INFO - TinderboxPrint: CPU usage
13.1% 02:59:05 INFO - TinderboxPrint: I/O read bytes / time
438,272 / 400 02:59:05 INFO - TinderboxPrint: I/O write bytes / time
403,136,512 / 239,072 02:59:05 INFO - TinderboxPrint: CPU idle
8,222.1 (86.9%) 02:59:05 INFO - TinderboxPrint: CPU user
1,191.8 (12.6%) 02:59:05 INFO - TinderboxPrint: Swap in / out
0 / 0 02:59:05 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 4096; Write bytes: 110112768; Read time: 192; Write time: 71876 02:59:05 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 02:59:05 INFO - run-tests - Wall time: 1171s; CPU: 13.0%; Read bytes: 434176; Write bytes: 293023744; Read time: 208; Write time: 167196 02:59:06 INFO - Running post-run listener: _upload_blobber_files 02:59:06 INFO - Blob upload gear active. 02:59:06 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:59:06 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 02:59:06 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-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 02:59:06 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-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 02:59:06 INFO - (blobuploader) - INFO - Open directory for files ... 02:59:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 02:59:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:59:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:59:13 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 02:59:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:59:13 INFO - (blobuploader) - INFO - Done attempting. 02:59:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log ... 02:59:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:59:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:59:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_errorsummary.log: uploaded 02:59:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:59:14 INFO - (blobuploader) - INFO - Done attempting. 02:59:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 02:59:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:59:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:59:15 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 02:59:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:59:15 INFO - (blobuploader) - INFO - Done attempting. 02:59:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log ... 02:59:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:59:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:59:16 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_raw.log: uploaded 02:59:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:59:16 INFO - (blobuploader) - INFO - Done attempting. 02:59:16 INFO - (blobuploader) - INFO - Iteration through files over. 02:59:16 INFO - Return code: 0 02:59:16 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:59:16 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:59:16 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8a05220aa777ce076f1ba75f2024ab3f284a9ee9bfed26866a5663b2af3813304e43ee7d4c3cc3782b0425488bcf8435c69065b622474ec335b3ec3294af0d61", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/522db8bdc1df37a39c94a5909b1e136ced98393d023f858f5d334deb01e41d8bae7ddfe378f319d02c43723557dffaa749281f9b44d6ae4afbe046cc7c4c7485", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d3dbb476a39088e9d6d904a307cf587e94c7c63ac769e35db73c9ea1d15aff613b4cfd977c4557a52aa12c7de9956b0067dc71041455991cca2c5bb525f8395d", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3d3d0d2e70ab0435458ad5879d8869c750620411565ec1dc315d38745cb07025113d5d6b43fc548b174fda6b47c9dab71677f1f1afd20c7587d2ce9fd1d8dc87"} 02:59:16 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:59:16 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:59:16 INFO - Contents: 02:59:16 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8a05220aa777ce076f1ba75f2024ab3f284a9ee9bfed26866a5663b2af3813304e43ee7d4c3cc3782b0425488bcf8435c69065b622474ec335b3ec3294af0d61", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/522db8bdc1df37a39c94a5909b1e136ced98393d023f858f5d334deb01e41d8bae7ddfe378f319d02c43723557dffaa749281f9b44d6ae4afbe046cc7c4c7485", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d3dbb476a39088e9d6d904a307cf587e94c7c63ac769e35db73c9ea1d15aff613b4cfd977c4557a52aa12c7de9956b0067dc71041455991cca2c5bb525f8395d", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3d3d0d2e70ab0435458ad5879d8869c750620411565ec1dc315d38745cb07025113d5d6b43fc548b174fda6b47c9dab71677f1f1afd20c7587d2ce9fd1d8dc87"} 02:59:16 INFO - Running post-run listener: copy_logs_to_upload_dir 02:59:16 INFO - Copying logs to upload dir... 02:59:16 INFO - mkdir: /builds/slave/test/build/upload/logs 02:59:16 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1253.147642 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2017-09-08 02:59:16.820739) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-08 02:59:16.824772) ========= 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-1504863418.753420-1283253239 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8a05220aa777ce076f1ba75f2024ab3f284a9ee9bfed26866a5663b2af3813304e43ee7d4c3cc3782b0425488bcf8435c69065b622474ec335b3ec3294af0d61", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/522db8bdc1df37a39c94a5909b1e136ced98393d023f858f5d334deb01e41d8bae7ddfe378f319d02c43723557dffaa749281f9b44d6ae4afbe046cc7c4c7485", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d3dbb476a39088e9d6d904a307cf587e94c7c63ac769e35db73c9ea1d15aff613b4cfd977c4557a52aa12c7de9956b0067dc71041455991cca2c5bb525f8395d", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3d3d0d2e70ab0435458ad5879d8869c750620411565ec1dc315d38745cb07025113d5d6b43fc548b174fda6b47c9dab71677f1f1afd20c7587d2ce9fd1d8dc87"} build_url:https://queue.taskcluster.net/v1/task/bhya0MgVT7S5tIHCfYUKiw/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011201 build_url: 'https://queue.taskcluster.net/v1/task/bhya0MgVT7S5tIHCfYUKiw/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8a05220aa777ce076f1ba75f2024ab3f284a9ee9bfed26866a5663b2af3813304e43ee7d4c3cc3782b0425488bcf8435c69065b622474ec335b3ec3294af0d61", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/522db8bdc1df37a39c94a5909b1e136ced98393d023f858f5d334deb01e41d8bae7ddfe378f319d02c43723557dffaa749281f9b44d6ae4afbe046cc7c4c7485", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d3dbb476a39088e9d6d904a307cf587e94c7c63ac769e35db73c9ea1d15aff613b4cfd977c4557a52aa12c7de9956b0067dc71041455991cca2c5bb525f8395d", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3d3d0d2e70ab0435458ad5879d8869c750620411565ec1dc315d38745cb07025113d5d6b43fc548b174fda6b47c9dab71677f1f1afd20c7587d2ce9fd1d8dc87"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-08 02:59:16.858425) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-08 02:59:16.858758) ========= 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-1504863418.753420-1283253239 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004619 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-08 02:59:16.941222) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-08 02:59:16.941528) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-08 02:59:16.941831) ========= ========= Total master_lag: 0.20 =========