builder: mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s slave: talos-linux64-ix-026 starttime: 1504212736.57 results: success (0) revision: 13d241d08912be31884f9d0d0e805b25343d6c0a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-08-31 13:52:16.567960) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-08-31 13:52:16.568349) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-31 13:52:16.568653) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-31 13:52:16.610831) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-31 13:52:16.611101) ========= 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=41bf3e9aed84707956354da8000001c5-1504212301.368790-1415861466 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-08-31 13:52:16-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 34.8M=0s 2017-08-31 13:52:16 (34.8 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.077028 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-31 13:52:16.710134) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-31 13:52:16.710509) ========= 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=41bf3e9aed84707956354da8000001c5-1504212301.368790-1415861466 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017021 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-31 13:52:16.761330) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-31 13:52:16.764884) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 13d241d08912be31884f9d0d0e805b25343d6c0a --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 13d241d08912be31884f9d0d0e805b25343d6c0a --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=41bf3e9aed84707956354da8000001c5-1504212301.368790-1415861466 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-08-31 13:52:16,933 truncating revision to first 12 chars 2017-08-31 13:52:16,933 Setting DEBUG logging. 2017-08-31 13:52:16,933 attempt 1/10 2017-08-31 13:52:16,933 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/13d241d08912?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-08-31 13:52:17,238 unpacking tar archive at: mozilla-central-13d241d08912/testing/mozharness/ program finished with exit code 0 elapsedTime=0.612776 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-31 13:52:17.393124) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-31 13:52:17.396492) ========= script_repo_revision: 13d241d08912be31884f9d0d0e805b25343d6c0a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-31 13:52:17.396952) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-31 13:52:17.397215) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-31 13:52:17.409629) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 51 secs) (at 2017-08-31 13:52:17.410013) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=41bf3e9aed84707956354da8000001c5-1504212301.368790-1415861466 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 13:52:17 INFO - MultiFileLogger online at 20170831 13:52:17 in /builds/slave/test 13:52:17 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 13:52:17 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:52:17 INFO - {'append_to_log': False, 13:52:17 INFO - 'base_work_dir': '/builds/slave/test', 13:52:17 INFO - 'blob_upload_branch': 'Firefox', 13:52:17 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:52:17 INFO - 'branch': 'Firefox', 13:52:17 INFO - 'buildbot_json_path': 'buildprops.json', 13:52:17 INFO - 'code_coverage': False, 13:52:17 INFO - 'config_files': ('talos/linux_config.py',), 13:52:17 INFO - 'default_actions': ('clobber', 13:52:17 INFO - 'read-buildbot-config', 13:52:17 INFO - 'download-and-extract', 13:52:17 INFO - 'populate-webroot', 13:52:17 INFO - 'create-virtualenv', 13:52:17 INFO - 'install', 13:52:17 INFO - 'setup-mitmproxy', 13:52:17 INFO - 'run-tests'), 13:52:17 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:52:17 INFO - 'disable_ccov_upload': False, 13:52:17 INFO - 'disable_stylo': False, 13:52:17 INFO - 'download_minidump_stackwalk': True, 13:52:17 INFO - 'download_symbols': 'ondemand', 13:52:17 INFO - 'enable_stylo': False, 13:52:17 INFO - 'enable_webrender': False, 13:52:17 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 13:52:17 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:52:17 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:52:17 INFO - 'gecko_profile': False, 13:52:17 INFO - 'gecko_profile_interval': 0, 13:52:17 INFO - 'installer_path': 'installer.exe', 13:52:17 INFO - 'log_level': 'info', 13:52:17 INFO - 'log_name': 'talos', 13:52:17 INFO - 'log_to_console': True, 13:52:17 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 13:52:17 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 13:52:17 INFO - 'opt_config_files': (), 13:52:17 INFO - 'pip_index': False, 13:52:17 INFO - 'suite': 'dromaeojs-e10s', 13:52:17 INFO - 'system_bits': '32', 13:52:17 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:52:17 INFO - 'title': 'talos-linux64-ix-026', 13:52:17 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:52:17 INFO - 'use_talos_json': True, 13:52:17 INFO - 'verify': 'False', 13:52:17 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:52:17 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:52:17 INFO - 'work_dir': 'build'} 13:52:17 INFO - [mozharness: 2017-08-31 20:52:17.715790Z] Running clobber step. 13:52:17 INFO - Running pre-action listener: _resource_record_pre_action 13:52:17 INFO - Running main action method: clobber 13:52:17 INFO - rmtree: /builds/slave/test/build 13:52:17 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:52:19 INFO - Running post-action listener: _resource_record_post_action 13:52:19 INFO - [mozharness: 2017-08-31 20:52:19.251720Z] Finished clobber step (success) 13:52:19 INFO - [mozharness: 2017-08-31 20:52:19.251817Z] Running read-buildbot-config step. 13:52:19 INFO - Running pre-action listener: _resource_record_pre_action 13:52:19 INFO - Running main action method: read_buildbot_config 13:52:19 INFO - Using buildbot properties: 13:52:19 INFO - { 13:52:19 INFO - "project": "", 13:52:19 INFO - "product": "firefox", 13:52:19 INFO - "who": "kwierso@gmail.com", 13:52:19 INFO - "installer_path": "public/build/target.tar.bz2", 13:52:19 INFO - "builddir": "mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s", 13:52:19 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 13:52:19 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo mozilla-central talos dromaeojs-e10s", 13:52:19 INFO - "stage_platform": "linux64-stylo", 13:52:19 INFO - "basedir": "/builds/slave/test", 13:52:19 INFO - "buildnumber": 68, 13:52:19 INFO - "platform": "ubuntu64_hw_stylo", 13:52:19 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 13:52:19 INFO - "slavebuilddir": "test", 13:52:19 INFO - "taskId": "II7J7cqmRmmxcYy_fLxR_g", 13:52:19 INFO - "branch": "mozilla-central", 13:52:19 INFO - "script_repo_revision": "production", 13:52:19 INFO - "revision": "13d241d08912be31884f9d0d0e805b25343d6c0a", 13:52:19 INFO - "slavename": "talos-linux64-ix-026", 13:52:19 INFO - "repo_path": "mozilla-central" 13:52:19 INFO - } 13:52:19 INFO - Finding installer, test and symbols from parent task. 13:52:19 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/II7J7cqmRmmxcYy_fLxR_g'}, attempt #1 13:52:19 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/II7J7cqmRmmxcYy_fLxR_g'}, attempt #1 13:52:20 INFO - Task dependencies: ZFWS62EnTCq2ZhmByr1xKg 13:52:20 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZFWS62EnTCq2ZhmByr1xKg'}, attempt #1 13:52:20 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/ZFWS62EnTCq2ZhmByr1xKg/artifacts/public/build/target.tar.bz2 13:52:20 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/ZFWS62EnTCq2ZhmByr1xKg/artifacts/public/build/target.test_packages.json 13:52:20 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/ZFWS62EnTCq2ZhmByr1xKg/artifacts/public/build/target.crashreporter-symbols.zip 13:52:20 INFO - Running post-action listener: _resource_record_post_action 13:52:20 INFO - [mozharness: 2017-08-31 20:52:20.623082Z] Finished read-buildbot-config step (success) 13:52:20 INFO - [mozharness: 2017-08-31 20:52:20.623297Z] Running download-and-extract step. 13:52:20 INFO - Running pre-action listener: _resource_record_pre_action 13:52:20 INFO - Running main action method: download_and_extract 13:52:20 INFO - mkdir: /builds/slave/test/build/tests 13:52:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:52:20 INFO - trying https://queue.taskcluster.net/v1/task/ZFWS62EnTCq2ZhmByr1xKg/artifacts/public/build/target.test_packages.json 13:52:20 INFO - Downloading https://queue.taskcluster.net/v1/task/ZFWS62EnTCq2ZhmByr1xKg/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 13:52:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZFWS62EnTCq2ZhmByr1xKg/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 13:52:21 INFO - Downloaded 989 bytes. 13:52:21 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 13:52:21 INFO - Using the following test package requirements: 13:52:21 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 13:52:21 INFO - u'common': [u'target.common.tests.zip'], 13:52:21 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 13:52:21 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 13:52:21 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 13:52:21 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 13:52:21 INFO - u'mozbase': [u'target.common.tests.zip'], 13:52:21 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 13:52:21 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 13:52:21 INFO - u'web-platform': [u'target.common.tests.zip', 13:52:21 INFO - u'target.web-platform.tests.tar.gz'], 13:52:21 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 13:52:21 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 13:52:21 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ZFWS62EnTCq2ZhmByr1xKg/artifacts/public/build/target.common.tests.zip 13:52:21 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZFWS62EnTCq2ZhmByr1xKg/artifacts/public/build/target.common.tests.zip'}, attempt #1 13:52:21 INFO - Fetch https://queue.taskcluster.net/v1/task/ZFWS62EnTCq2ZhmByr1xKg/artifacts/public/build/target.common.tests.zip into memory 13:52:23 INFO - Content-Length response header: 54932967 13:52:23 INFO - Bytes received: 54932967 13:52:33 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 13:52:33 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ZFWS62EnTCq2ZhmByr1xKg/artifacts/public/build/target.common.tests.zip 13:52:33 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZFWS62EnTCq2ZhmByr1xKg/artifacts/public/build/target.common.tests.zip'}, attempt #1 13:52:33 INFO - Fetch https://queue.taskcluster.net/v1/task/ZFWS62EnTCq2ZhmByr1xKg/artifacts/public/build/target.common.tests.zip into memory 13:52:35 INFO - Content-Length response header: 54932967 13:52:35 INFO - Bytes received: 54932967 13:52:47 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ZFWS62EnTCq2ZhmByr1xKg/artifacts/public/build/target.talos.tests.zip 13:52:47 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZFWS62EnTCq2ZhmByr1xKg/artifacts/public/build/target.talos.tests.zip'}, attempt #1 13:52:47 INFO - Fetch https://queue.taskcluster.net/v1/task/ZFWS62EnTCq2ZhmByr1xKg/artifacts/public/build/target.talos.tests.zip into memory 13:52:48 INFO - Content-Length response header: 14496650 13:52:48 INFO - Bytes received: 14496650 13:52:48 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')]} 13:52:48 INFO - trying https://queue.taskcluster.net/v1/task/ZFWS62EnTCq2ZhmByr1xKg/artifacts/public/build/target.tar.bz2 13:52:48 INFO - Downloading https://queue.taskcluster.net/v1/task/ZFWS62EnTCq2ZhmByr1xKg/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 13:52:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZFWS62EnTCq2ZhmByr1xKg/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 13:52:51 INFO - Downloaded 62641049 bytes. 13:52:51 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ZFWS62EnTCq2ZhmByr1xKg/artifacts/public/build/target.tar.bz2 13:52:51 INFO - mkdir: /builds/slave/test/properties 13:52:51 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:52:51 INFO - Writing to file /builds/slave/test/properties/build_url 13:52:51 INFO - Contents: 13:52:51 INFO - build_url:https://queue.taskcluster.net/v1/task/ZFWS62EnTCq2ZhmByr1xKg/artifacts/public/build/target.tar.bz2 13:52:51 INFO - Running post-action listener: _resource_record_post_action 13:52:51 INFO - Running post-action listener: find_tests_for_verification 13:52:51 INFO - Running post-action listener: set_extra_try_arguments 13:52:51 INFO - [mozharness: 2017-08-31 20:52:51.181584Z] Finished download-and-extract step (success) 13:52:51 INFO - [mozharness: 2017-08-31 20:52:51.181809Z] Running populate-webroot step. 13:52:51 INFO - Running pre-action listener: _resource_record_pre_action 13:52:51 INFO - Running main action method: populate_webroot 13:52:51 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:52:51 INFO - 'chromez-stylo-e10s': {'talos_options': ['--enable-stylo'], 13:52:51 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:52:51 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:52:51 INFO - 'dromaeojs-stylo-e10s': {'talos_options': ['--enable-stylo'], 13:52:51 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:52:51 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 13:52:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:52:51 INFO - 'g1-stylo-e10s': {'pagesets_name': 'tp5n.zip', 13:52:51 INFO - 'talos_options': ['--enable-stylo'], 13:52:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:52:51 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 13:52:51 INFO - 'tests': ['damp', 'tps']}, 13:52:51 INFO - 'g2-stylo-e10s': {'pagesets_name': 'tp5n.zip', 13:52:51 INFO - 'talos_options': ['--enable-stylo'], 13:52:51 INFO - 'tests': ['damp', 'tps']}, 13:52:51 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:52:51 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 13:52:51 INFO - 'g4-stylo-e10s': {'talos_options': ['--enable-stylo'], 13:52:51 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 13:52:51 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 13:52:51 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 13:52:51 INFO - 'g5-stylo-e10s': {'pagesets_name': 'tp5n.zip', 13:52:51 INFO - 'talos_options': ['--enable-stylo'], 13:52:51 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 13:52:51 INFO - 'other-e10s': {'tests': ['a11yr', 13:52:51 INFO - 'ts_paint', 13:52:51 INFO - 'tpaint', 13:52:51 INFO - 'sessionrestore', 13:52:51 INFO - 'sessionrestore_many_windows', 13:52:51 INFO - 'sessionrestore_no_auto_restore', 13:52:51 INFO - 'tabpaint']}, 13:52:51 INFO - 'other-stylo-e10s': {'talos_options': ['--enable-stylo'], 13:52:51 INFO - 'tests': ['a11yr', 13:52:51 INFO - 'ts_paint', 13:52:51 INFO - 'tpaint', 13:52:51 INFO - 'sessionrestore', 13:52:51 INFO - 'sessionrestore_many_windows', 13:52:51 INFO - 'sessionrestore_no_auto_restore', 13:52:51 INFO - 'tabpaint']}, 13:52:51 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 13:52:51 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 13:52:51 INFO - 'perf-reftest-singletons-stylo-e10s': {'talos_options': ['--enable-stylo'], 13:52:51 INFO - 'tests': ['bloom_basic_singleton']}, 13:52:51 INFO - 'perf-reftest-stylo-e10s': {'talos_options': ['--enable-stylo'], 13:52:51 INFO - 'tests': ['bloom_basic']}, 13:52:51 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:52:51 INFO - 'tsvgr_opacity', 13:52:51 INFO - 'tart', 13:52:51 INFO - 'tscrollx', 13:52:51 INFO - 'tsvg_static']}, 13:52:51 INFO - 'svgr-stylo-e10s': {'talos_options': ['--enable-stylo'], 13:52:51 INFO - 'tests': ['tsvgx', 13:52:51 INFO - 'tsvgr_opacity', 13:52:51 INFO - 'tart', 13:52:51 INFO - 'tscrollx', 13:52:51 INFO - 'tsvg_static']}, 13:52:51 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 13:52:51 INFO - 'tp5o-stylo-e10s': {'pagesets_name': 'tp5n.zip', 13:52:51 INFO - 'talos_options': ['--enable-stylo'], 13:52:51 INFO - 'tests': ['tp5o']}, 13:52:51 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 13:52:51 INFO - 'talos_options': ['--mitmproxy', 13:52:51 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 13:52:51 INFO - '--firstNonBlankPaint'], 13:52:51 INFO - 'tests': ['tp6_google', 13:52:51 INFO - 'tp6_youtube', 13:52:51 INFO - 'tp6_amazon', 13:52:51 INFO - 'tp6_facebook']}, 13:52:51 INFO - 'tp6-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 13:52:51 INFO - 'talos_options': ['--enable-stylo', 13:52:51 INFO - '--mitmproxy', 13:52:51 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 13:52:51 INFO - '--firstNonBlankPaint'], 13:52:51 INFO - 'tests': ['tp6_google', 13:52:51 INFO - 'tp6_youtube', 13:52:51 INFO - 'tp6_amazon', 13:52:51 INFO - 'tp6_facebook']}, 13:52:51 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 13:52:51 INFO - 'talos_options': ['--enable-stylo', 13:52:51 INFO - '--stylo-threads=1', 13:52:51 INFO - '--mitmproxy', 13:52:51 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 13:52:51 INFO - '--firstNonBlankPaint'], 13:52:51 INFO - 'tests': ['tp6_google', 13:52:51 INFO - 'tp6_youtube', 13:52:51 INFO - 'tp6_amazon', 13:52:51 INFO - 'tp6_facebook']}, 13:52:51 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 13:52:51 INFO - 'talos_options': ['--xperf_path', 13:52:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:52:51 INFO - 'tests': ['tp5n']}, 13:52:51 INFO - 'xperf-stylo-e10s': {'pagesets_name': 'tp5n.zip', 13:52:51 INFO - 'talos_options': ['--enable-stylo', 13:52:51 INFO - '--xperf_path', 13:52:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:52:51 INFO - 'tests': ['tp5n']}}} 13:52:51 INFO - Running post-action listener: _resource_record_post_action 13:52:51 INFO - [mozharness: 2017-08-31 20:52:51.200818Z] Finished populate-webroot step (success) 13:52:51 INFO - [mozharness: 2017-08-31 20:52:51.200906Z] Running create-virtualenv step. 13:52:51 INFO - Running pre-action listener: _resource_record_pre_action 13:52:51 INFO - Running main action method: create_virtualenv 13:52:51 INFO - Creating virtualenv /builds/slave/test/build/venv 13:52:51 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 13:52:51 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 13:52:51 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 13:52:51 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:52:51 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:52:51 INFO - Installing distribute.............................................................................................................................................................................................done. 13:52:52 INFO - Installing pip...............done. 13:52:52 INFO - Return code: 0 13:52:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 13:52:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 13:52:52 INFO - Reading from file tmpfile_stdout 13:52:52 INFO - Output received: 13:52:52 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 13:52:52 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:52:52 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')]} 13:52:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:52:52 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')]} 13:52:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:52:52 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 0x21001f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22c9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x246ca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2470090>, '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 0x2470d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x246af90>, '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': '41bf3e9aed84707956354da8000001c5-1504212301.368790-1415861466', '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 13:52:52 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 13:52:52 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 13:52:52 INFO - Using env: {'DISPLAY': ':0', 13:52:52 INFO - 'HOME': '/home/cltbld', 13:52:52 INFO - 'LANG': 'en_US.UTF-8', 13:52:52 INFO - 'LANGUAGE': 'en_US:en', 13:52:52 INFO - 'LOGNAME': 'cltbld', 13:52:52 INFO - 'MAIL': '/var/mail/cltbld', 13:52:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:52:52 INFO - 'MOZ_NO_REMOTE': '1', 13:52:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:52:52 INFO - 'NO_EM_RESTART': '1', 13:52:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:52:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:52:52 INFO - 'PWD': '/builds/slave/test', 13:52:52 INFO - 'SHELL': '/bin/bash', 13:52:52 INFO - 'SHLVL': '1', 13:52:52 INFO - 'TERM': 'linux', 13:52:52 INFO - 'TMOUT': '86400', 13:52:52 INFO - 'USER': 'cltbld', 13:52:52 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1504212301.368790-1415861466', 13:52:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:52:52 INFO - '_': '/tools/buildbot/bin/python'} 13:52:53 INFO - Ignoring indexes: http://pypi.python.org/simple/ 13:52:53 INFO - Downloading/unpacking pip>=1.5 13:52:53 INFO - Running setup.py egg_info for package pip 13:52:53 INFO - warning: no files found matching 'pip/cacert.pem' 13:52:53 INFO - warning: no files found matching '*.html' under directory 'docs' 13:52:53 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 13:52:53 INFO - no previously-included directories found matching 'docs/_build/_sources' 13:52:53 INFO - Installing collected packages: pip 13:52:53 INFO - Found existing installation: pip 1.1 13:52:53 INFO - Uninstalling pip: 13:52:53 INFO - Successfully uninstalled pip 13:52:53 INFO - Running setup.py install for pip 13:52:53 INFO - warning: no files found matching 'pip/cacert.pem' 13:52:53 INFO - warning: no files found matching '*.html' under directory 'docs' 13:52:53 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 13:52:53 INFO - no previously-included directories found matching 'docs/_build/_sources' 13:52:53 INFO - Installing pip script to /builds/slave/test/build/venv/bin 13:52:53 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 13:52:53 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 13:52:53 INFO - Successfully installed pip 13:52:53 INFO - Cleaning up... 13:52:53 INFO - Return code: 0 13:52:53 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 13:52:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:52:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:52:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:52:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:52:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21001f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22c9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x246ca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2470090>, '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 0x2470d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x246af90>, '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': '41bf3e9aed84707956354da8000001c5-1504212301.368790-1415861466', '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 13:52:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 13:52:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 13:52:53 INFO - Using env: {'DISPLAY': ':0', 13:52:53 INFO - 'HOME': '/home/cltbld', 13:52:53 INFO - 'LANG': 'en_US.UTF-8', 13:52:53 INFO - 'LANGUAGE': 'en_US:en', 13:52:53 INFO - 'LOGNAME': 'cltbld', 13:52:53 INFO - 'MAIL': '/var/mail/cltbld', 13:52:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:52:53 INFO - 'MOZ_NO_REMOTE': '1', 13:52:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:52:53 INFO - 'NO_EM_RESTART': '1', 13:52:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:52:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:52:53 INFO - 'PWD': '/builds/slave/test', 13:52:53 INFO - 'SHELL': '/bin/bash', 13:52:53 INFO - 'SHLVL': '1', 13:52:53 INFO - 'TERM': 'linux', 13:52:53 INFO - 'TMOUT': '86400', 13:52:53 INFO - 'USER': 'cltbld', 13:52:53 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1504212301.368790-1415861466', 13:52:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:52:53 INFO - '_': '/tools/buildbot/bin/python'} 13:52:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:52:53 INFO - Downloading/unpacking psutil>=3.1.1 13:52:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:52:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:52:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:52:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:52:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:52:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:52:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:52:54 INFO - Installing collected packages: psutil 13:52:54 INFO - Running setup.py install for psutil 13:52:54 INFO - building 'psutil._psutil_linux' extension 13:52:54 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 13:52:55 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 13:52:55 INFO - building 'psutil._psutil_posix' extension 13:52:55 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 13:52:55 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 13:52:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:52:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:52:55 INFO - Successfully installed psutil 13:52:55 INFO - Cleaning up... 13:52:55 INFO - Return code: 0 13:52:55 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 13:52:55 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')]} 13:52:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:52:55 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')]} 13:52:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:52:55 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 0x21001f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22c9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x246ca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2470090>, '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 0x2470d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x246af90>, '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': '41bf3e9aed84707956354da8000001c5-1504212301.368790-1415861466', '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 13:52:55 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 13:52:55 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 13:52:55 INFO - Using env: {'DISPLAY': ':0', 13:52:55 INFO - 'HOME': '/home/cltbld', 13:52:55 INFO - 'LANG': 'en_US.UTF-8', 13:52:55 INFO - 'LANGUAGE': 'en_US:en', 13:52:55 INFO - 'LOGNAME': 'cltbld', 13:52:55 INFO - 'MAIL': '/var/mail/cltbld', 13:52:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:52:55 INFO - 'MOZ_NO_REMOTE': '1', 13:52:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:52:55 INFO - 'NO_EM_RESTART': '1', 13:52:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:52:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:52:55 INFO - 'PWD': '/builds/slave/test', 13:52:55 INFO - 'SHELL': '/bin/bash', 13:52:55 INFO - 'SHLVL': '1', 13:52:55 INFO - 'TERM': 'linux', 13:52:55 INFO - 'TMOUT': '86400', 13:52:55 INFO - 'USER': 'cltbld', 13:52:55 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1504212301.368790-1415861466', 13:52:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:52:55 INFO - '_': '/tools/buildbot/bin/python'} 13:52:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:52:55 INFO - Downloading/unpacking mozsystemmonitor==0.3 13:52:55 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 13:52:55 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 13:52:55 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 13:52:55 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 13:52:57 INFO - Downloading mozsystemmonitor-0.3.tar.gz 13:52:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:52:57 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 13:52:57 INFO - Installing collected packages: mozsystemmonitor 13:52:57 INFO - Running setup.py install for mozsystemmonitor 13:52:57 INFO - Successfully installed mozsystemmonitor 13:52:57 INFO - Cleaning up... 13:52:57 INFO - Return code: 0 13:52:57 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 13:52: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')]} 13:52:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:52: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')]} 13:52:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:52:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x21001f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22c9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x246ca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2470090>, '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 0x2470d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x246af90>, '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': '41bf3e9aed84707956354da8000001c5-1504212301.368790-1415861466', '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 13:52:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 13:52:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 13:52:57 INFO - Using env: {'DISPLAY': ':0', 13:52:57 INFO - 'HOME': '/home/cltbld', 13:52:57 INFO - 'LANG': 'en_US.UTF-8', 13:52:57 INFO - 'LANGUAGE': 'en_US:en', 13:52:57 INFO - 'LOGNAME': 'cltbld', 13:52:57 INFO - 'MAIL': '/var/mail/cltbld', 13:52:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:52:57 INFO - 'MOZ_NO_REMOTE': '1', 13:52:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:52:57 INFO - 'NO_EM_RESTART': '1', 13:52:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:52:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:52:57 INFO - 'PWD': '/builds/slave/test', 13:52:57 INFO - 'SHELL': '/bin/bash', 13:52:57 INFO - 'SHLVL': '1', 13:52:57 INFO - 'TERM': 'linux', 13:52:57 INFO - 'TMOUT': '86400', 13:52:57 INFO - 'USER': 'cltbld', 13:52:57 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1504212301.368790-1415861466', 13:52:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:52:57 INFO - '_': '/tools/buildbot/bin/python'} 13:52:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:52:58 INFO - Downloading/unpacking jsonschema==2.5.1 13:52:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:52:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:52:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:52:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:52:59 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:52:59 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 13:52:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:52:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:52:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:52:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:52:59 INFO - Downloading functools32-3.2.3-2.tar.gz 13:52:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:52:59 INFO - warning: no files found matching '*.txt' 13:52:59 INFO - no previously-included directories found matching 'build' 13:52:59 INFO - no previously-included directories found matching 'dist' 13:52:59 INFO - no previously-included directories found matching '.git*' 13:52:59 INFO - Installing collected packages: jsonschema, functools32 13:52:59 INFO - Running setup.py install for functools32 13:52:59 INFO - warning: no files found matching '*.txt' 13:52:59 INFO - no previously-included directories found matching 'build' 13:52:59 INFO - no previously-included directories found matching 'dist' 13:52:59 INFO - no previously-included directories found matching '.git*' 13:52:59 INFO - Successfully installed jsonschema functools32 13:52:59 INFO - Cleaning up... 13:52:59 INFO - Return code: 0 13:52:59 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 13:52: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')]} 13:52:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:52: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')]} 13:52:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:52: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', '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 0x21001f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22c9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x246ca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2470090>, '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 0x2470d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x246af90>, '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': '41bf3e9aed84707956354da8000001c5-1504212301.368790-1415861466', '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 13:52: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 13:52: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 functools32==3.2.3-2 13:52:59 INFO - Using env: {'DISPLAY': ':0', 13:52:59 INFO - 'HOME': '/home/cltbld', 13:52:59 INFO - 'LANG': 'en_US.UTF-8', 13:52:59 INFO - 'LANGUAGE': 'en_US:en', 13:52:59 INFO - 'LOGNAME': 'cltbld', 13:52:59 INFO - 'MAIL': '/var/mail/cltbld', 13:52:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:52:59 INFO - 'MOZ_NO_REMOTE': '1', 13:52:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:52:59 INFO - 'NO_EM_RESTART': '1', 13:52:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:52:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:52:59 INFO - 'PWD': '/builds/slave/test', 13:52:59 INFO - 'SHELL': '/bin/bash', 13:52:59 INFO - 'SHLVL': '1', 13:52:59 INFO - 'TERM': 'linux', 13:52:59 INFO - 'TMOUT': '86400', 13:52:59 INFO - 'USER': 'cltbld', 13:52:59 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1504212301.368790-1415861466', 13:52:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:52:59 INFO - '_': '/tools/buildbot/bin/python'} 13:52:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:52:59 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 13:52:59 INFO - Cleaning up... 13:52:59 INFO - Return code: 0 13:52:59 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:52: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')]} 13:52:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:52: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')]} 13:52:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:52: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', '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 0x21001f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22c9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x246ca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2470090>, '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 0x2470d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x246af90>, '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': '41bf3e9aed84707956354da8000001c5-1504212301.368790-1415861466', '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 13:52: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 13:52: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 blobuploader==1.2.4 13:52:59 INFO - Using env: {'DISPLAY': ':0', 13:52:59 INFO - 'HOME': '/home/cltbld', 13:52:59 INFO - 'LANG': 'en_US.UTF-8', 13:52:59 INFO - 'LANGUAGE': 'en_US:en', 13:52:59 INFO - 'LOGNAME': 'cltbld', 13:52:59 INFO - 'MAIL': '/var/mail/cltbld', 13:52:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:52:59 INFO - 'MOZ_NO_REMOTE': '1', 13:52:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:52:59 INFO - 'NO_EM_RESTART': '1', 13:52:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:52:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:52:59 INFO - 'PWD': '/builds/slave/test', 13:52:59 INFO - 'SHELL': '/bin/bash', 13:52:59 INFO - 'SHLVL': '1', 13:52:59 INFO - 'TERM': 'linux', 13:52:59 INFO - 'TMOUT': '86400', 13:52:59 INFO - 'USER': 'cltbld', 13:52:59 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1504212301.368790-1415861466', 13:52:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:52:59 INFO - '_': '/tools/buildbot/bin/python'} 13:52:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:52:59 INFO - Downloading/unpacking blobuploader==1.2.4 13:52:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:52:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:52:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:52:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:53:01 INFO - Downloading blobuploader-1.2.4.tar.gz 13:53:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:53:01 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:53: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 13:53: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 13:53: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 13:53: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 13:53:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:53:01 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:53: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 13:53: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 13:53: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 13:53: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 13:53:01 INFO - Downloading docopt-0.6.1.tar.gz 13:53:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:53:01 INFO - Installing collected packages: blobuploader, requests, docopt 13:53:01 INFO - Running setup.py install for blobuploader 13:53:01 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:53:01 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:53:01 INFO - Running setup.py install for requests 13:53:02 INFO - Running setup.py install for docopt 13:53:02 INFO - Successfully installed blobuploader requests docopt 13:53:02 INFO - Cleaning up... 13:53:02 INFO - Return code: 0 13:53:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:53:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:53:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:53:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:53:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:53:02 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 0x21001f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22c9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x246ca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2470090>, '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 0x2470d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x246af90>, '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': '41bf3e9aed84707956354da8000001c5-1504212301.368790-1415861466', '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 13:53:02 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 13:53:02 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 13:53:02 INFO - Using env: {'DISPLAY': ':0', 13:53:02 INFO - 'HOME': '/home/cltbld', 13:53:02 INFO - 'LANG': 'en_US.UTF-8', 13:53:02 INFO - 'LANGUAGE': 'en_US:en', 13:53:02 INFO - 'LOGNAME': 'cltbld', 13:53:02 INFO - 'MAIL': '/var/mail/cltbld', 13:53:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:53:02 INFO - 'MOZ_NO_REMOTE': '1', 13:53:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:53:02 INFO - 'NO_EM_RESTART': '1', 13:53:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:53:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:53:02 INFO - 'PWD': '/builds/slave/test', 13:53:02 INFO - 'SHELL': '/bin/bash', 13:53:02 INFO - 'SHLVL': '1', 13:53:02 INFO - 'TERM': 'linux', 13:53:02 INFO - 'TMOUT': '86400', 13:53:02 INFO - 'USER': 'cltbld', 13:53:02 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1504212301.368790-1415861466', 13:53:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:53:02 INFO - '_': '/tools/buildbot/bin/python'} 13:53:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:53:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:53:02 INFO - Running setup.py (path:/tmp/pip-zQu5ce-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:53:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:53:02 INFO - Running setup.py (path:/tmp/pip-1RnoSU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:53:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:53:02 INFO - Running setup.py (path:/tmp/pip-Kl8H35-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:53:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:53:02 INFO - Running setup.py (path:/tmp/pip-FrVrsb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:53:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:53:02 INFO - Running setup.py (path:/tmp/pip-IANl50-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:53:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:53:02 INFO - Running setup.py (path:/tmp/pip-B8NTOm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:53:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:53:02 INFO - Running setup.py (path:/tmp/pip-LVHuJV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:53:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:53:02 INFO - Running setup.py (path:/tmp/pip-FRqn0t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:53:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:53:02 INFO - Running setup.py (path:/tmp/pip-dE2T3L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:53:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:53:03 INFO - Running setup.py (path:/tmp/pip-W4DInu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:53:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:53:03 INFO - Running setup.py (path:/tmp/pip-rjCs6k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:53:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:53:03 INFO - Running setup.py (path:/tmp/pip-E644oE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:53:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:53:03 INFO - Running setup.py (path:/tmp/pip-l1LDSA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:53:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:53:03 INFO - Running setup.py (path:/tmp/pip-jP3CyQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:53:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:53:03 INFO - Running setup.py (path:/tmp/pip-G4GoE9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:53:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:53:03 INFO - Running setup.py (path:/tmp/pip-oX2lX2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:53:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:53:03 INFO - Running setup.py (path:/tmp/pip-XY3xCQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:53:03 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:53:03 INFO - Running setup.py install for manifestparser 13:53:03 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:53:03 INFO - Running setup.py install for mozcrash 13:53:03 INFO - Running setup.py install for mozdebug 13:53:03 INFO - Running setup.py install for mozdevice 13:53:04 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:53:04 INFO - Running setup.py install for mozfile 13:53:04 INFO - Running setup.py install for mozhttpd 13:53:04 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:53:04 INFO - Running setup.py install for mozinfo 13:53:04 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:53:04 INFO - Running setup.py install for mozInstall 13:53:04 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:53:04 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:53:04 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:53:04 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:53:04 INFO - Running setup.py install for mozleak 13:53:04 INFO - Running setup.py install for mozlog 13:53:04 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:53:04 INFO - Running setup.py install for moznetwork 13:53:04 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:53:04 INFO - Running setup.py install for mozprocess 13:53:04 INFO - Running setup.py install for mozprofile 13:53:04 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:53:04 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:53:04 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:53:04 INFO - Running setup.py install for mozrunner 13:53:05 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:53:05 INFO - Running setup.py install for mozscreenshot 13:53:05 INFO - Running setup.py install for moztest 13:53:05 INFO - Running setup.py install for mozversion 13:53:05 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:53:05 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:53:05 INFO - Cleaning up... 13:53:05 INFO - Return code: 0 13:53:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:53:05 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')]} 13:53:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:53:05 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')]} 13:53:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:53:05 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 0x21001f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22c9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x246ca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2470090>, '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 0x2470d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x246af90>, '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': '41bf3e9aed84707956354da8000001c5-1504212301.368790-1415861466', '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 13:53:05 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 13:53:05 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 13:53:05 INFO - Using env: {'DISPLAY': ':0', 13:53:05 INFO - 'HOME': '/home/cltbld', 13:53:05 INFO - 'LANG': 'en_US.UTF-8', 13:53:05 INFO - 'LANGUAGE': 'en_US:en', 13:53:05 INFO - 'LOGNAME': 'cltbld', 13:53:05 INFO - 'MAIL': '/var/mail/cltbld', 13:53:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:53:05 INFO - 'MOZ_NO_REMOTE': '1', 13:53:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:53:05 INFO - 'NO_EM_RESTART': '1', 13:53:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:53:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:53:05 INFO - 'PWD': '/builds/slave/test', 13:53:05 INFO - 'SHELL': '/bin/bash', 13:53:05 INFO - 'SHLVL': '1', 13:53:05 INFO - 'TERM': 'linux', 13:53:05 INFO - 'TMOUT': '86400', 13:53:05 INFO - 'USER': 'cltbld', 13:53:05 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1504212301.368790-1415861466', 13:53:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:53:05 INFO - '_': '/tools/buildbot/bin/python'} 13:53:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:53:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:53:05 INFO - Running setup.py (path:/tmp/pip-RWhGw3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:53:05 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)) 13:53:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:53:05 INFO - Running setup.py (path:/tmp/pip-51hKVl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:53:05 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)) 13:53:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:53:05 INFO - Running setup.py (path:/tmp/pip-guIM4x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:53:05 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)) 13:53:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:53:05 INFO - Running setup.py (path:/tmp/pip-F7mTu_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:53:05 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)) 13:53:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:53:05 INFO - Running setup.py (path:/tmp/pip-HjMBv9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:53:06 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)) 13:53:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:53:06 INFO - Running setup.py (path:/tmp/pip-lxsqMZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:53:06 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)) 13:53:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:53:06 INFO - Running setup.py (path:/tmp/pip-s6bt_B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:53:06 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)) 13:53:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:53:06 INFO - Running setup.py (path:/tmp/pip-9NdZJX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:53:06 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)) 13:53:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:53:06 INFO - Running setup.py (path:/tmp/pip-n0NkxO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:53:06 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)) 13:53:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:53:06 INFO - Running setup.py (path:/tmp/pip-IWXy9K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:53:06 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)) 13:53:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:53:06 INFO - Running setup.py (path:/tmp/pip-Ukbg3R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:53:06 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)) 13:53:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:53:06 INFO - Running setup.py (path:/tmp/pip-cpfWtC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:53:06 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)) 13:53:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:53:06 INFO - Running setup.py (path:/tmp/pip-efLezh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:53:06 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)) 13:53:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:53:06 INFO - Running setup.py (path:/tmp/pip-_AaqPz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:53:06 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)) 13:53:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:53:06 INFO - Running setup.py (path:/tmp/pip-YrkPUc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:53:06 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)) 13:53:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:53:06 INFO - Running setup.py (path:/tmp/pip-DM9UVZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:53:06 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)) 13:53:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:53:06 INFO - Running setup.py (path:/tmp/pip-rV7wpx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:53:06 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)) 13:53:06 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)) 13:53:06 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)) 13:53:06 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)) 13:53:06 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)) 13:53:06 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)) 13:53:06 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)) 13:53:06 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:53: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 13:53: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 13:53: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 13:53: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 13:53:07 INFO - Downloading blessings-1.6.tar.gz 13:53:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:53:08 INFO - Installing collected packages: blessings 13:53:08 INFO - Running setup.py install for blessings 13:53:08 INFO - Successfully installed blessings 13:53:08 INFO - Cleaning up... 13:53:08 INFO - Return code: 0 13:53:08 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:53:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:53:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:53:08 INFO - Reading from file tmpfile_stdout 13:53:08 INFO - Current package versions: 13:53:08 INFO - argparse == 1.2.1 13:53:08 INFO - blessings == 1.6 13:53:08 INFO - blobuploader == 1.2.4 13:53:08 INFO - docopt == 0.6.1 13:53:08 INFO - functools32 == 3.2.3-2 13:53:08 INFO - jsonschema == 2.5.1 13:53:08 INFO - manifestparser == 1.1 13:53:08 INFO - mozInstall == 1.13 13:53:08 INFO - mozcrash == 1.0 13:53:08 INFO - mozdebug == 0.1 13:53:08 INFO - mozdevice == 0.51 13:53:08 INFO - mozfile == 1.2 13:53:08 INFO - mozhttpd == 0.7 13:53:08 INFO - mozinfo == 0.10 13:53:08 INFO - mozleak == 0.1 13:53:08 INFO - mozlog == 3.5 13:53:08 INFO - moznetwork == 0.27 13:53:08 INFO - mozprocess == 0.25 13:53:08 INFO - mozprofile == 0.28 13:53:08 INFO - mozrunner == 6.13 13:53:08 INFO - mozscreenshot == 0.1 13:53:08 INFO - mozsystemmonitor == 0.3 13:53:08 INFO - moztest == 0.8 13:53:08 INFO - mozversion == 1.4 13:53:08 INFO - psutil == 3.1.1 13:53:08 INFO - requests == 1.2.3 13:53:08 INFO - wsgiref == 0.1.2 13:53:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:53: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')]} 13:53:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:53: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')]} 13:53:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:53:08 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 0x21001f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22c9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x246ca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2470090>, '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 0x2470d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x246af90>, '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': '41bf3e9aed84707956354da8000001c5-1504212301.368790-1415861466', '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 13:53:08 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 13:53:08 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 13:53:08 INFO - Using env: {'DISPLAY': ':0', 13:53:08 INFO - 'HOME': '/home/cltbld', 13:53:08 INFO - 'LANG': 'en_US.UTF-8', 13:53:08 INFO - 'LANGUAGE': 'en_US:en', 13:53:08 INFO - 'LOGNAME': 'cltbld', 13:53:08 INFO - 'MAIL': '/var/mail/cltbld', 13:53:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:53:08 INFO - 'MOZ_NO_REMOTE': '1', 13:53:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:53:08 INFO - 'NO_EM_RESTART': '1', 13:53:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:53:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:53:08 INFO - 'PWD': '/builds/slave/test', 13:53:08 INFO - 'SHELL': '/bin/bash', 13:53:08 INFO - 'SHLVL': '1', 13:53:08 INFO - 'TERM': 'linux', 13:53:08 INFO - 'TMOUT': '86400', 13:53:08 INFO - 'USER': 'cltbld', 13:53:08 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1504212301.368790-1415861466', 13:53:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:53:08 INFO - '_': '/tools/buildbot/bin/python'} 13:53:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:53:08 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)) 13:53:08 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)) 13:53:08 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)) 13:53:08 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)) 13:53:08 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)) 13:53:08 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)) 13:53:08 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)) 13:53:08 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)) 13:53:08 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)) 13:53:08 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 13:53: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 13:53: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 13:53: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 13:53: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 13:53:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 13:53:10 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)) 13:53:10 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)) 13:53:10 INFO - Installing collected packages: simplejson 13:53:10 INFO - Running setup.py install for simplejson 13:53:10 INFO - building 'simplejson._speedups' extension 13:53:10 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 13:53:11 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 13:53:11 INFO - Successfully installed simplejson 13:53:11 INFO - Cleaning up... 13:53:11 INFO - Return code: 0 13:53:11 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:53:11 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')]} 13:53:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:53:11 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')]} 13:53:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:53:11 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 0x21001f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22c9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x246ca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2470090>, '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 0x2470d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x246af90>, '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': '41bf3e9aed84707956354da8000001c5-1504212301.368790-1415861466', '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 13:53:11 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 13:53:11 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 13:53:11 INFO - Using env: {'DISPLAY': ':0', 13:53:11 INFO - 'HOME': '/home/cltbld', 13:53:11 INFO - 'LANG': 'en_US.UTF-8', 13:53:11 INFO - 'LANGUAGE': 'en_US:en', 13:53:11 INFO - 'LOGNAME': 'cltbld', 13:53:11 INFO - 'MAIL': '/var/mail/cltbld', 13:53:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:53:11 INFO - 'MOZ_NO_REMOTE': '1', 13:53:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:53:11 INFO - 'NO_EM_RESTART': '1', 13:53:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:53:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:53:11 INFO - 'PWD': '/builds/slave/test', 13:53:11 INFO - 'SHELL': '/bin/bash', 13:53:11 INFO - 'SHLVL': '1', 13:53:11 INFO - 'TERM': 'linux', 13:53:11 INFO - 'TMOUT': '86400', 13:53:11 INFO - 'USER': 'cltbld', 13:53:11 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1504212301.368790-1415861466', 13:53:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:53:11 INFO - '_': '/tools/buildbot/bin/python'} 13:53:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:53:12 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 13:53:12 INFO - Cleaning up... 13:53:12 INFO - Return code: 0 13:53:12 INFO - Running post-action listener: _resource_record_post_action 13:53:12 INFO - Running post-action listener: _start_resource_monitoring 13:53:12 INFO - Starting resource monitoring. 13:53:12 INFO - [mozharness: 2017-08-31 20:53:12.110856Z] Finished create-virtualenv step (success) 13:53:12 INFO - [mozharness: 2017-08-31 20:53:12.111325Z] Running install step. 13:53:12 INFO - Running pre-action listener: _resource_record_pre_action 13:53:12 INFO - Running main action method: install 13:53:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:53:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:53:12 INFO - Reading from file tmpfile_stdout 13:53:12 INFO - Detecting whether we're running mozinstall >=1.0... 13:53:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:53:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:53:12 INFO - Reading from file tmpfile_stdout 13:53:12 INFO - Output received: 13:53:12 INFO - Usage: mozinstall [options] installer 13:53:12 INFO - Options: 13:53:12 INFO - -h, --help show this help message and exit 13:53:12 INFO - -d DEST, --destination=DEST 13:53:12 INFO - Directory to install application into. [default: 13:53:12 INFO - "/builds/slave/test"] 13:53:12 INFO - --app=APP Application being installed. [default: firefox] 13:53:12 INFO - mkdir: /builds/slave/test/build/application 13:53:12 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'] 13:53:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 13:53:28 INFO - Reading from file tmpfile_stdout 13:53:28 INFO - Output received: 13:53:28 INFO - /builds/slave/test/build/application/firefox/firefox 13:53:28 INFO - Running post-action listener: _resource_record_post_action 13:53:28 INFO - [mozharness: 2017-08-31 20:53:28.927842Z] Finished install step (success) 13:53:28 INFO - [mozharness: 2017-08-31 20:53:28.928095Z] Running setup-mitmproxy step. 13:53:28 INFO - Running pre-action listener: _resource_record_pre_action 13:53:28 INFO - Running main action method: setup_mitmproxy 13:53:28 INFO - Skipping: mitmproxy is not required 13:53:28 INFO - Running post-action listener: _resource_record_post_action 13:53:28 INFO - [mozharness: 2017-08-31 20:53:28.929235Z] Finished setup-mitmproxy step (success) 13:53:28 INFO - [mozharness: 2017-08-31 20:53:28.929564Z] Running run-tests step. 13:53:28 INFO - Running pre-action listener: _resource_record_pre_action 13:53:28 INFO - Running pre-action listener: _set_gcov_prefix 13:53:28 INFO - Running main action method: run_tests 13:53:28 WARNING - Try message not found. 13:53:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:53:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:53:28 INFO - Python 2.7.3 13:53:28 INFO - Return code: 0 13:53:28 INFO - grabbing minidump binary from tooltool 13:53:28 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')]} 13:53:28 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 0x2470090>, '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 0x2470d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x246af90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:53:28 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 13:53:28 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 13:53:28 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 13:53:29 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:53:29 INFO - Return code: 0 13:53:29 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 13:53:29 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:53:29 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:53:29 INFO - ENV: RUST_BACKTRACE is now full 13:53:29 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 13:53:29 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:53:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ZFWS62EnTCq2ZhmByr1xKg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-026', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 13:53:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ZFWS62EnTCq2ZhmByr1xKg/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-026 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 13:53:29 INFO - Using env: {'DISPLAY': ':0', 13:53:29 INFO - 'HOME': '/home/cltbld', 13:53:29 INFO - 'LANG': 'en_US.UTF-8', 13:53:29 INFO - 'LANGUAGE': 'en_US:en', 13:53:29 INFO - 'LOGNAME': 'cltbld', 13:53:29 INFO - 'MAIL': '/var/mail/cltbld', 13:53:29 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:53:29 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 13:53:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:53:29 INFO - 'MOZ_NO_REMOTE': '1', 13:53:29 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:53:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:53:29 INFO - 'NO_EM_RESTART': '1', 13:53:29 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:53:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:53:29 INFO - 'PWD': '/builds/slave/test', 13:53:29 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:53:29 INFO - 'RUST_BACKTRACE': 'full', 13:53:29 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 13:53:29 INFO - 'SHELL': '/bin/bash', 13:53:29 INFO - 'SHLVL': '1', 13:53:29 INFO - 'STYLO_FORCE_ENABLED': '1', 13:53:29 INFO - 'TERM': 'linux', 13:53:29 INFO - 'TMOUT': '86400', 13:53:29 INFO - 'USER': 'cltbld', 13:53:29 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1504212301.368790-1415861466', 13:53:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:53:29 INFO - '_': '/tools/buildbot/bin/python'} 13:53:29 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ZFWS62EnTCq2ZhmByr1xKg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-026', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 13:53:29 INFO - mozversion application_buildid: 20170831195811 13:53:29 INFO - mozversion application_changeset: 13d241d08912be31884f9d0d0e805b25343d6c0a 13:53:29 INFO - mozversion application_display_name: Nightly 13:53:29 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:53:29 INFO - mozversion application_name: Firefox 13:53:29 INFO - mozversion application_remotingname: firefox 13:53:29 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 13:53:29 INFO - mozversion application_vendor: Mozilla 13:53:29 INFO - mozversion application_version: 57.0a1 13:53:29 INFO - mozversion platform_buildid: 20170831195811 13:53:29 INFO - mozversion platform_changeset: 13d241d08912be31884f9d0d0e805b25343d6c0a 13:53:29 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 13:53:29 INFO - mozversion platform_version: 57.0a1 13:53:29 INFO - using testdate: 1504212809 13:53:29 INFO - actual date: 1504212809 13:53:29 INFO - starting webserver on 'localhost:56408' 13:53:29 INFO - SUITE-START | Running 2 tests 13:53:29 INFO - TEST-START | dromaeo_css 13:53:29 INFO - Initialising browser for dromaeo_css test... 13:53:29 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:56408/getInfo.html -profile /tmp/tmpAdClxj/profile 13:53:29 INFO - TEST-INFO | started process 9772 (/builds/slave/test/build/application/firefox/firefox http://localhost:56408/getInfo.html) 13:53:35 INFO - TEST-INFO | 9772: exit 0 13:53:35 INFO - Browser initialized. 13:53:35 INFO - Running cycle 1/1 for dromaeo_css test... 13:53:35 INFO - Using env: {'DISPLAY': ':0', 13:53:35 INFO - 'HOME': '/home/cltbld', 13:53:35 INFO - 'JSGC_DISABLE_POISONING': '1', 13:53:35 INFO - 'LANG': 'en_US.UTF-8', 13:53:35 INFO - 'LANGUAGE': 'en_US:en', 13:53:35 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 13:53:35 INFO - 'LOGNAME': 'cltbld', 13:53:35 INFO - 'MAIL': '/var/mail/cltbld', 13:53:35 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:53:35 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 13:53:35 INFO - 'MOZ_CRASHREPORTER': '1', 13:53:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:53:35 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 13:53:35 INFO - 'MOZ_NO_REMOTE': '1', 13:53:35 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:53:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:53:35 INFO - 'NO_EM_RESTART': '1', 13:53:35 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:53:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:53:35 INFO - 'PWD': '/builds/slave/test', 13:53:35 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:53:35 INFO - 'RUST_BACKTRACE': 'full', 13:53:35 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 13:53:35 INFO - 'SHELL': '/bin/bash', 13:53:35 INFO - 'SHLVL': '1', 13:53:35 INFO - 'STYLO_FORCE_ENABLED': '1', 13:53:35 INFO - 'TERM': 'linux', 13:53:35 INFO - 'TMOUT': '86400', 13:53:35 INFO - 'USER': 'cltbld', 13:53:35 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1504212301.368790-1415861466', 13:53:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:53:35 INFO - '_': '/tools/buildbot/bin/python'} 13:53:35 INFO - TEST-INFO | started process 9969 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpAdClxj/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 13:53:36 INFO - PID 9969 | 13:53:36 INFO - PID 9969 | (/builds/slave/test/build/application/firefox/firefox:10020): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 13:53:36 INFO - PID 9969 | 13:53:46 INFO - PID 9969 | RSS: Main: 167489536 13:53:46 INFO - PID 9969 | 13:56:45 INFO - PID 9969 | Cycle 1(1): loaded http://localhost:56408/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56408/tests/dromaeo/cssquery-ext.html) 13:56:46 INFO - PID 9969 | RSS: Main: 173719552 13:56:46 INFO - PID 9969 | 13:59:48 INFO - PID 9969 | Cycle 1(1): loaded http://localhost:56408/tests/dromaeo/cssquery-ext.html (next: http://localhost:56408/tests/dromaeo/cssquery-jquery.html) 13:59:48 INFO - PID 9969 | RSS: Main: 170029056 13:59:48 INFO - PID 9969 | 14:02:50 INFO - PID 9969 | Cycle 1(1): loaded http://localhost:56408/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56408/tests/dromaeo/cssquery-mootools.html) 14:02:51 INFO - PID 9969 | RSS: Main: 170393600 14:02:51 INFO - PID 9969 | 14:05:52 INFO - PID 9969 | Cycle 1(1): loaded http://localhost:56408/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56408/tests/dromaeo/cssquery-prototype.html) 14:05:53 INFO - PID 9969 | RSS: Main: 171335680 14:05:53 INFO - PID 9969 | 14:08:57 INFO - PID 9969 | Cycle 1(1): loaded http://localhost:56408/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56408/tests/dromaeo/cssquery-yui.html) 14:08:57 INFO - PID 9969 | RSS: Main: 172199936 14:08:57 INFO - PID 9969 | 14:11:59 INFO - PID 9969 | Cycle 1(1): loaded http://localhost:56408/tests/dromaeo/cssquery-yui.html (next: http://localhost:56408/tests/dromaeo/cssquery-dojo.html) 14:11:59 INFO - PID 9969 | RSS: Main: 175194112 14:11:59 INFO - PID 9969 | 14:11:59 INFO - PID 9969 | __start_tp_report 14:11:59 INFO - PID 9969 | _x_x_mozilla_page_load 14:11:59 INFO - PID 9969 | _x_x_mozilla_page_load_details 14:11:59 INFO - PID 9969 | |i|pagename|runs| 14:11:59 INFO - PID 9969 | |0;dojo.html;3300.042987533614;3318.1870441741776;3326.800391976481;3349.330133973206;3352.463605823069;6282.528810339231;6316.399942005508;6371.426571608555;6380.680965951707;6394.1367915331475;6228;6324.652144132071;6326.968365158179;6333.429991300782;6339.302676705559;5773.971130144354;5792.131180322943;5806.10005449154;5809.477147056764;5843;5832.708364581775;5871.677057761843;5908.02517584598;5963.344032156459;5978.8206353809455;5850.619709718876;5923.14114453404;5937.317208521011;5988.610740301889;5992.940070599304;5680.4319568043275;5753.827385178452;5802.825915222508;5870.884531938918;5892.764289428418;5639;5771.047777116771;5772.278465191851;5867.941320586782;5884.558658100659;6233;6343.333949935237;6375.2987171411105;6383.808485745389;6391.77628782995;6674.365935236145;6730.326967303279;6736.5958042517605;6759.662016899185;6778.864422711518;6891.689873955684;6905.620190889499;6910.343517365842;6917.688704008332;6931.653417329164;6359.745610175587;6376.617402955838;6413.6793160341795;6442.226932768098;6451.451626611697;7013.123359580052;7068.646567671596;7137.785866424016;7142.357187853118;7159.284071592799;6471.449926756279;6539.215294164635;6584.374484423972;6616.834579135464;6721.327867213239;6759.459243260528;6760.830979225559;6761;6768.086308348408;6775.93224067753;6709.329067093252;6744.494162937701;6753.223379311442;6765.594064356154;6771.4582833373215;6754.5947243165565;6771.322867713189;6776.11910451648;6784.966075169593;6788.287229840895;5278.181881808326;5287.259783630295;5292.841214763486;5300.893982120413;5316;4610.193216187221;4688.976555117202;4693.741844198602;4696.647751418589;4717.24524076153;5720.599558030898;5775;5889.028310328834;5894.2926848778425;5974.3428222895445;6743.460523158135;6745.696443660047;6773.627450490172;6815.2843951385385;6825.35159159879;5944.138099975479;5962.612430192024;5963.224780778471;5965.403459654;5971.940280597139;5826.912596311059;5832.825015249549;5868.295804503487;5868.295804503487;5881.764729410861;6569.277379488252;6631.171103612145;6658.966705166443;6661.467082633378;6666.333366663392;6774.220964589135;6778.356056174655;6789.388954994074;6879.484038697218;6892.586444813327;6433.453156481752;6500.122483464672;6516.837079073061;6576.145101137013;6657.600543967377;6681.532292739462;6695.564788288746;6719.361660642231;6742.69657865407;6791.72833086671;6835.58986460814;6866.279040700854;6923.065386173003;6934.410575100971;6944;6577.835554110994;6607.141071660653;6617.404433600999;6712.328767123248;6712.6979285931275;6605.933940660724;6643.667816609247;6665.633390163587;6668.266490686117;6672.132622759011;6546.672666366568;6558.737650494118;6602.10871532337;6638.336166383323;6638.90041649366;6660.134182556237;6677.131972843499;6679.699413526306;6729.461643068445;6770.119884414995;6191.690415479298;6290.905636415366;6375.553711240169;6518.413342799171;6544.574602650812 14:11:59 INFO - PID 9969 | |1;ext.html;819.1439945257206;860.1570460948271;884.0938038510526;886.9423487473314;1135.0579019413876;37316.44025339622;40888;40938.59061409389;40976.18047639045;40977.59022409775;40320.59679403205;41174.38238426426;41542.37686434706;41633;41642;7747.961260193705;7875.606219689022;7876;7925.128235894047;7927.3658107351275;7762;7842.294193522582;7859.960700196491;7860.842783144362;7863.292303692667;7856.646450909694;7861.21387861215;7890.289873911347;7894.921050789476;7918.129005809356;7852.489588176751;7868.134505204423;7874.251946065115;7877.4485785995;7894.526328420285;7736.110347310075;7764.767056988299;7801.0638723352995;7821.100573434014;7822.843543129163;37666.43500347497;37723.811380943196;37734;37772.62227377718;37947.43078853819;3530;3560.2701446203723;3566;3566.7503274770775;3576.946345804815;31097.844510777526;31295.06114816559;31348.37303253922;31425;31445.685543144733;5053.469385714484;5222.843314700565;5234.241035049935;5266.4733526647415;5299.417064122943;183135;183454;183551;184015;184528;46208.07583848304;46572;46826.29760553595;46949.29576056362;47067;52984;53834.19248711273;53936.46063539393;54008.189877151875;54150.729246354305;13199.47202111924;13479.123856949267;15106.773398399033;15158.621034474007;15420.228988550753;12283;12411.193272437444;12421.75156496883;12438.564650237198;12448.564300249629;14306.141631502143;14372.20347456568;14378.856211437751;14480.927595361956;14584;5804.332501762267;5822.737976791054;5847.356790753014;5907.143464197753;5924.822255332347;1005.6631028605499;1010.1918465227789;1011.175891648319;1014.2950649298666;1017.2878984710732;22755.658665120038;22806.885965570396;22951.655725164135;22962.19632312861;22991.54016919686;1099.5107177306181;1111.1943840715578;1113.7438389170536;1117.958579734271;1126.189143816451;12126.696832579257;12228.938855305667;12255.571055013032;12265.632031039084;12278.693032674255;235682;237097;237400;237433;237555;51284.48715512797;51586.48413515817;51599.48400516022;51675;51689.483105169216;1424.8005279260913;1462.926853657313;1478.068816645528;1484.5101116631486;1495.53638372105;22264.66603000989;22295.331140065824;22405.887970560696;22459.32622021342;22933.197338093752;37763.24473510569;37785.433218501195;37824.24351512899;37962;37994.62005379911;190067;190302;190327;190874;191038;32745.18137046593;33820.83089584536;34110.829445852614;34168.48747268843;34218.657813421545;41655.1668966625;41880.79059604683;42078.36882446827;45849;46228.768856155504;33055.83472082624;33354.83322583372;33453.16367090842;33762.15594610056;33849.15377115592;32950.50574241341;33231.33537329288;33364.83317583494;33764.83117584397;33861.153471163416;37413;37491.43762843505;37759;37779.244415112094;38073.4288985671;32678.673213267564;33069.33861322712;33196.33607327888;33234.83382583072;33269.50095748614;23975.76024239735;24092.036318547063;24296.1496347627;24441.633375499736;24737 14:11:59 INFO - PID 9969 | |2;jquery.html;565.9179418984245;569.8091139468278;570.623388563548;571.611304313067;577.99711001445;22199.44501387466;22297.331080067604;23249.535009299805;23302.65046024307;23308.533829323445;24998.375040623992;25414.36464088399;25461.872690636566;25500.74499255007;25535;6586.506012049092;6741.157355330583;6742.561733487332;6760.1549806274215;6760.695768690396;6053.273607167146;6592.637404942726;6622.73509059637;6625.17185351831;6652.567583107107;6578.440832529241;6594.1427614410295;6594.571352862049;6603.14159159311;6618.602883826961;6611.834704132387;6618.569792963442;6618.569792963466;6619.5035372347265;6622.53642245043;6126.23422072241;6128.877422451526;6143.078538219258;6143.692815359259;6146.108814221958;27810.860945695345;28520;29106;29107;29284.707152928626;2007.036622421246;2029.9391018269475;2031.0149577454922;2032.9796702032938;2033.4204751645857;19291;19901.701474477893;19916.900415497974;19943.102560384672;19949.601007979905;2357.39886328985;2364.4443555764383;2382.3686723018413;2411.1801987324393;2476.418041760185;128083;135752;135759;136054.31972840172;136276;13955.930220348833;14886.404543818342;14955.812372535707;15026.924865375822;15419;22525.324240272817;22623.66064509034;22695.546089078125;22723.318300451014;22740.772592274196;9957.950210249048;10020.142245235636;10082.24383171265;10125.443100629536;10126.645567405105;7666.769996900102;9200.30997675177;9240.168384845396;9268.165865072177;9277.67528136512;7839.529628222325;9178.21985131258;9178.449293042439;9355.812883742286;9439.224310275944;2700.3519155402564;2726.768224700883;2731.740484653955;2757.6415066041286;2858.099698594936;970.9951450242703;975.1662328708993;989.3717489394143;991.509202944547;999.8300288950895;19043.42869713911;19562.51093722668;20072;20173.798262017193;20388.28640997558;1040.9167266618651;1041.7812259425455;1042.207921979301;1044.5926088825365;1059.3961441978154;10669.199810014125;10876.347419154876;11076.11391088711;11080.667579972614;11203.439828008566;471889;479588;483570;485399;487395;103057.48471257745;104828;109968.4501577487;110288.4485577567;112588.43705781418;1153.8038533449335;1175.9941200293945;1193.1945936493007;1193.886580774825;1202.3086725133082;16865.578360541083;17047.91476042612;17333.47999560015;17572.648547028733;17666.5583360417;53471.177320512805;54985.450145498035;55038.449615504935;55071;57385.426145738005;66936.66531667311;71151;74597.62701186459;74752;75668;12330.19853709506;12875.420606072561;14496.782548261996;14922.626934326729;21115.683264751347;23764.405889852893;23927.28218153458;24251;24815.627765583893;24850.254492365257;18551.16519756587;18687.345942891934;19273.807261927202;19379.224831006602;19426.805731943066;16201.75697364517;16400.75398868994;16868.325266989184;17077.146142692567;18041.097945102956;19223.231070757014;19281.61436771285;19539.609207816047;19826.90086549558;19849.801501984795;20743;20758.896205518875;20770;20803.583928321044;20860.68708969397;16929.407470738464;19097;19231.711524327427;19240.326588569333;19685.507862302984 14:11:59 INFO - PID 9969 | |3;mootools.html;1336.9799453008204;1375.5185685010247;1402.193738600305;1402.6843960108974;1403.3825116948549;12441.253524788519;14956.551303460887;15488.690226195484;15556.377744890206;15585.29866156023;12501.43743531541;14820.40718371264;15360.692786144271;15393.614574688276;15410.229488525585;2746.6292050573165;2807.6490438695164;2807.985960070207;2810.3536186676974;2812.057960583207;2711.4712631036955;2802.285417218606;2802.845843478608;2802.985985070072;2804.4250928559595;2761.1164427383146;2782.7217278272215;2783.485055264772;2786.0527420676967;2794.413173233623;2664.267326485213;2695.7978151638704;2698.2040298112006;2701.419194873102;2703.080952476148;2630.040035387089;2645.854478003709;2648.894044238228;2651.64202832619;2660.4546068056;14613.926930365387;14875.925620371938;14892.106473611619;14897.925510372486;14903.180325082116;7949.920500795034;8254.174582541698;8260.504369737835;8265;8265.214804593554;4902.607791376681;5171;5322.547583455411;5327.387350454708;5500.889982200333;1771.446515174923;1840.6226723521645;1871.5695390060225;1880.9717854232197;1881.4543782303115;25972.480550389075;25993.350166245807;26032.8698356507;26044.869775651;26095;7289.635518224173;7312.341889229995;7324.926750732425;7393.445491588045;7409.444291678145;19329.903350483157;19423.611527769648;19446.124924378437;19467.415977520697;19472.221111155395;8140.226678465537;8153.062397824327;8168.142345053802;8172.918270817335;8179.591020449073;5933.732982015819;6111.694415279218;6284.214473190851;7287.817804554928;7308.524945878501;5558.082916318843;5702.515286200636;5729.713514324267;5776.971115144482;5840.8247752567495;1811.501836994837;1822.6081392500676;1838.7241913712783;1846.4368367647996;1876.052593440304;881.2377293640955;892.7544925145637;896.5741272895323;902.8871391076116;910.1308250620641;8381.49711017341;8489.70286039998;8566.3146948244;8645.870311945326;8693.478391296543;723.1141851232198;726.1612837173074;727.4980263618087;729.8576777528331;734.566605702638;4368.628666563314;4402.8679139625865;4407.294832826732;4471.217536931089;4485.753283569435;20134.597308053755;21068.47328816792;21102.366928992156;21109.366718998455;21116.366509004754;19804.306849260207;21061;21069.78930210709;21071.68392474114;21112.366629001153;10943.179261555415;10962.671119866416;11265.662030139109;11267.605633802777;11296.20926535151;8449.535275559903;8797.780055498664;8827.205551500396;8830.116988301119;8842.734717958472;18508.537286567942;18809.153588088295;19170.904145479184;19228.807711923262;19439.3196238131;18745.34391296298;19005.23979040878;19129.808701912803;19280.132394042022;19473.8052619472;11688.532458701557;11907.809219078023;11960.820587691018;11960.880391196324;11962.222455540363;13963.720725585228;13972.580822575339;14063.226522541358;14087.859121409065;14092.718145637235;11446.656600302003;11624.476898539417;11650.067994560584;11819.40902954866;11921.463534141158;10493.108085812792;10719.088877445505;10735.302205356627;10821.56713731442;11003.834942475709;9241.21449676785;9398.154166125081;9432.292578056811;9493.715188544355;9513.619455221713;6255.437010669061;6398.648074355955;6430.839229019312;6447.516436267392;6554.4756419485375;7183.20984691673;7254.093238345207;7333.596652184181;7355.852882942204;7374.151972523228 14:11:59 INFO - PID 9969 | |4;prototype.html;497.5053253084392;509.14463700982344;522.0993785719631;527.9762410691519;528.5824198882883;6203.193584833971;6283.575451378998;6300.30696623371;6348.80953571393;6384;6224.19085518883;6269.467095296905;6275.968620156893;6285.882746800841;6311.905321420182;5145.382554093495;5171.276021357013;5174.379074511064;5185.896282074356;5227.2159176123505;4750.16872047392;5118.872028199287;5144.819931302405;5185.507376799217;5198.584113270948;4836.758162091881;4907.11671899058;4952.182889823175;4956.801727930879;4961.652684312099;4898.485659005789;4911.926321105187;4939.925901111468;4975.975120124413;4990.951900100965;4335.1329734053;4409.07409444014;4423;4449.1101779644205;4480.753558554278;6014.278286605591;6015.428534289235;6083.6045657032155;6099.512039036911;6134.110553969694;5615.213870058195;5674.659520428788;5689.431056894319;5729.5702822288495;5735.397783232742;6588.901166482507;6605.900911486331;6606.273309935903;6612.371824676648;6630.370114839083;4869.172240719051;4872.610191184732;4885.43817460993;4890.1367919343675;4891.217405215149;6585.452418681606;6679.499037572153;6757.729690812362;6788.59268443895;6852.554583952027;4962.801487940515;4988;4996.4503904570465;4996.925046124311;5014.974925125424;5062;5067.771950262247;5073.590044728798;5084.669496482717;5092;5613.382527921925;5642.6614403135945;5654.935948378894;5663.745131469093;5715.228444160069;6631.834204144935;6642.788992292222;6643.701033453506;6670.199576050808;6689.397954184147;1745.821570439948;1765.2144795566107;1769.027035130673;1772.97340539892;1775.2810111904698;1152.262551966742;1199.2744389644315;1218.6473014953394;1227.9815802762967;1229.3730197599289;5644.85887852807;5766.423357664284;5787.276590426197;5792.160136780143;5800.245968024215;6647;6681.164854393201;6707.3292670732535;6727.865442691119;6728.158980127484;5639.8590035249445;5641.153826925994;5734.426557344315;5743.54051675865;5768.221290125864;3493.9650603494147;3529.5588051493564;3544.8404821783083;3549.8580056797955;3576.783893476231;6421.389967953037;6473.190851143607;6489.1888513935755;6510.153680021567;6554.967225163844;6859.485538584527;6862.965685171542;6880.901325095794;6895.75864844728;6900.482463815234;5934.43622855828;6252.280987686474;6265.592736472115;6401;6448.774292899726;6578.980258060008;6622.238442579165;6658.766943156967;6680.6993685283305;6695.832604184934;6534.170432278969;6562.671866406565;6639.933600663931;6654.536002079535;6694.4644428444635;6544.574602650812;6548.574342667712;6568.6058836469965;6596.406323430914;6611.636360000246;5007.524285192901;5033;5033.84898453047;5042.899142017212;5072.188449848007;6514.446272066927;6626.4096616812585;6668.933310666831;6813.523053386215;6827.726890924308;6355.173827402408;6496.707648155939;6540;6577.14497115372;6597.868042639025;6477.578957367756;6499.837504062436;6513.73945042193;6551.70517326731;6557.967210163919;6481.4166724994975;6488.70800813974;6491.383318584727;6495.545311828127;6502.479801615954;6525;6588.868222635425;6637.800865974028;6649.567778094409;6654.401103900672;6232.470240029648;6325.557210995186;6382.936170638234;6398.680065996588;6410.647414392253 14:11:59 INFO - PID 9969 | |5;yui.html;909.1454033208784;918.7014220378377;929.1498279074647;929.697848199335;934.2992755433424;17976;18835.623287534276;18903.149358278857;19001.239950401985;22192.445188870286;19493.220271189137;19512.804871951277;19764.604707905833;19765.802341976578;19769.308074217406;704.4258928972896;715.3633266392915;937.779621788879;944.7874228298613;945.1493655709882;1000.0799264676479;1000.6747806962729;1001.2140469731262;1002.3334482569082;1002.8194924913513;1037.9636712715057;1044.9111825494842;1045.3571053801934;1046.2257929132425;1050.2333296693419;1036.3004971644186;1041.6927006533092;1045.1325399918087;1045.3362115056955;1048.958041678332;764.900562926816;766.5324152267112;769.0924708843562;769.7536788227769;770.5107256891858;17913.462596122135;18111.63776724458;18235.54411139719;19147.52131196717;20107.798922010737;21195.78804211969;21427;21832.23587174441;21832.781672183235;21896;16409.179541022902;16643.91678041614;16754.497365079067;16763.413280535246;16894.915525422293;3708.4251940948925;3719.9628003719886;3722.720795940288;3726.4782930389765;3726.981365093184;121683;124904.37547812294;125326.99999999908;126385.99999999908;127774;16895.32418703238;17270.395536156426;17548.73676894822;17593;17628;29907.70092299049;30637.540436893465;30915.69084309128;31247;31266.843665781525;8592.097829727914;8672.436291641023;8688.087750786077;8696.130386961253;8709.91290087091;3519.4017017107153;3532;3755.981220093937;3801.82891769871;4183.100633363781;4948.8762780930765;5082.034413461431;5085.923711144335;5088.0587091388215;5102.923456148086;1072.8605281313535;1095.8356246562919;1106.3251416635846;1117.6311817100338;1118.5749415222162;581.8748968971606;612.9141920131185;627.5575719118011;629.3549112160073;650.6291413894035;10843.295185812896;11739.11956603241;11874.228175168586;12189.451474683661;12206.633800985985;605.7455868535226;605.9636421814705;631.0723236841835;646.7897933171738;653.1411194279507;5566.777328906798;5626.971865140648;5666.97166514173;6039.396060393926;6240.781572644935;107749;107753;108251.91748082418;112192;112209;93694;94440.52779736057;95450;96718.54922176032;97104;85912.14087859166;86254;89687.55156224308;90280.5485972566;91033;11612.419379031184;11772.234804738007;12398.13213075076;12482.313472758722;12496.625101246977;41103.38344924888;41575.58424415838;41808.37287440752;42166.15667686691;42780;68977;70436.64781676263;72736.09055637715;73887.63056184685;77579.61210193913;15828.28772705254;16096.839031610003;16116.194190290673;16119.355225791307;16177.75733364024;16572.917135414245;17583.120843957495;17699;17769.555761106076;18197.45407637773;17480.562985925455;17716.734248986017;18000.279988800303;18032.459026229233;18239.635207296044;17626.64746705033;17703.64592708113;17711.734323984892;17830.732539011668;18230.72653910219;16625.418110366078;16880.915595421946;16942.915285423493;17032.48902532926;17186.31254749796;12096.153269271066;12412.75174496487;12587;12770.76511610446;13009.349532523525;13689.520866769615;13996.370163342877;14018.158910465405;14067.788983165465;14210.147391156564 14:11:59 INFO - PID 9969 | __end_tp_report 14:11:59 INFO - PID 9969 | __start_cc_report 14:11:59 INFO - PID 9969 | _x_x_mozilla_cycle_collect,351 14:11:59 INFO - PID 9969 | __end_cc_report 14:11:59 INFO - PID 9969 | __startTimestamp1504213919898__endTimestamp 14:11:59 INFO - PID 9969 | 14:11:59 INFO - PID 9969 | ------- Summary: start ------- 14:11:59 INFO - PID 9969 | Number of tests: 6 14:11:59 INFO - PID 9969 | 14:11:59 INFO - PID 9969 | [#0] dojo.html Cycles:165 Average:6261.87 Median:6518.41 stddev:735.03 (11.3%) stddev-sans-first:699.60 14:11:59 INFO - PID 9969 | Values: 3300.0 3318.2 3326.8 3349.3 3352.5 6282.5 6316.4 6371.4 6380.7 6394.1 6228.0 6324.7 6327.0 6333.4 6339.3 5774.0 5792.1 5806.1 5809.5 5843.0 5832.7 5871.7 5908.0 5963.3 5978.8 5850.6 5923.1 5937.3 5988.6 5992.9 5680.4 5753.8 5802.8 5870.9 5892.8 5639.0 5771.0 5772.3 5867.9 5884.6 6233.0 6343.3 6375.3 6383.8 6391.8 6674.4 6730.3 6736.6 6759.7 6778.9 6891.7 6905.6 6910.3 6917.7 6931.7 6359.7 6376.6 6413.7 6442.2 6451.5 7013.1 7068.6 7137.8 7142.4 7159.3 6471.4 6539.2 6584.4 6616.8 6721.3 6759.5 6760.8 6761.0 6768.1 6775.9 6709.3 6744.5 6753.2 6765.6 6771.5 6754.6 6771.3 6776.1 6785.0 6788.3 5278.2 5287.3 5292.8 5300.9 5316.0 4610.2 4689.0 4693.7 4696.6 4717.2 5720.6 5775.0 5889.0 5894.3 5974.3 6743.5 6745.7 6773.6 6815.3 6825.4 5944.1 5962.6 5963.2 5965.4 5971.9 5826.9 5832.8 5868.3 5868.3 5881.8 6569.3 6631.2 6659.0 6661.5 6666.3 6774.2 6778.4 6789.4 6879.5 6892.6 6433.5 6500.1 6516.8 6576.1 6657.6 6681.5 6695.6 6719.4 6742.7 6791.7 6835.6 6866.3 6923.1 6934.4 6944.0 6577.8 6607.1 6617.4 6712.3 6712.7 6605.9 6643.7 6665.6 6668.3 6672.1 6546.7 6558.7 6602.1 6638.3 6638.9 6660.1 6677.1 6679.7 6729.5 6770.1 6191.7 6290.9 6375.6 6518.4 6544.6 14:11:59 INFO - PID 9969 | 14:11:59 INFO - PID 9969 | [#1] ext.html Cycles:180 Average:37457.90 Median:18874.33 stddev:53157.48 (281.6%) stddev-sans-first:53235.41 14:11:59 INFO - PID 9969 | Values: 819.1 860.2 884.1 886.9 1135.1 37316.4 40888.0 40938.6 40976.2 40977.6 40320.6 41174.4 41542.4 41633.0 41642.0 7748.0 7875.6 7876.0 7925.1 7927.4 7762.0 7842.3 7860.0 7860.8 7863.3 7856.6 7861.2 7890.3 7894.9 7918.1 7852.5 7868.1 7874.3 7877.4 7894.5 7736.1 7764.8 7801.1 7821.1 7822.8 37666.4 37723.8 37734.0 37772.6 37947.4 3530.0 3560.3 3566.0 3566.8 3576.9 31097.8 31295.1 31348.4 31425.0 31445.7 5053.5 5222.8 5234.2 5266.5 5299.4 183135.0 183454.0 183551.0 184015.0 184528.0 46208.1 46572.0 46826.3 46949.3 47067.0 52984.0 53834.2 53936.5 54008.2 54150.7 13199.5 13479.1 15106.8 15158.6 15420.2 12283.0 12411.2 12421.8 12438.6 12448.6 14306.1 14372.2 14378.9 14480.9 14584.0 5804.3 5822.7 5847.4 5907.1 5924.8 1005.7 1010.2 1011.2 1014.3 1017.3 22755.7 22806.9 22951.7 22962.2 22991.5 1099.5 1111.2 1113.7 1118.0 1126.2 12126.7 12228.9 12255.6 12265.6 12278.7 235682.0 237097.0 237400.0 237433.0 237555.0 51284.5 51586.5 51599.5 51675.0 51689.5 1424.8 1462.9 1478.1 1484.5 1495.5 22264.7 22295.3 22405.9 22459.3 22933.2 37763.2 37785.4 37824.2 37962.0 37994.6 190067.0 190302.0 190327.0 190874.0 191038.0 32745.2 33820.8 34110.8 34168.5 34218.7 41655.2 41880.8 42078.4 45849.0 46228.8 33055.8 33354.8 33453.2 33762.2 33849.2 32950.5 33231.3 33364.8 33764.8 33861.2 37413.0 37491.4 37759.0 37779.2 38073.4 32678.7 33069.3 33196.3 33234.8 33269.5 23975.8 24092.0 24296.1 24441.6 24737.0 14:11:59 INFO - PID 9969 | 14:11:59 INFO - PID 9969 | [#2] jquery.html Cycles:180 Average:34459.05 Median:22995.15 stddev:80913.74 (351.9%) stddev-sans-first:81100.71 14:11:59 INFO - PID 9969 | Values: 565.9 569.8 570.6 571.6 578.0 22199.4 22297.3 23249.5 23302.7 23308.5 24998.4 25414.4 25461.9 25500.7 25535.0 6586.5 6741.2 6742.6 6760.2 6760.7 6053.3 6592.6 6622.7 6625.2 6652.6 6578.4 6594.1 6594.6 6603.1 6618.6 6611.8 6618.6 6618.6 6619.5 6622.5 6126.2 6128.9 6143.1 6143.7 6146.1 27810.9 28520.0 29106.0 29107.0 29284.7 2007.0 2029.9 2031.0 2033.0 2033.4 19291.0 19901.7 19916.9 19943.1 19949.6 2357.4 2364.4 2382.4 2411.2 2476.4 128083.0 135752.0 135759.0 136054.3 136276.0 13955.9 14886.4 14955.8 15026.9 15419.0 22525.3 22623.7 22695.5 22723.3 22740.8 9958.0 10020.1 10082.2 10125.4 10126.6 7666.8 9200.3 9240.2 9268.2 9277.7 7839.5 9178.2 9178.4 9355.8 9439.2 2700.4 2726.8 2731.7 2757.6 2858.1 971.0 975.2 989.4 991.5 999.8 19043.4 19562.5 20072.0 20173.8 20388.3 1040.9 1041.8 1042.2 1044.6 1059.4 10669.2 10876.3 11076.1 11080.7 11203.4 471889.0 479588.0 483570.0 485399.0 487395.0 103057.5 104828.0 109968.5 110288.4 112588.4 1153.8 1176.0 1193.2 1193.9 1202.3 16865.6 17047.9 17333.5 17572.6 17666.6 53471.2 54985.5 55038.4 55071.0 57385.4 66936.7 71151.0 74597.6 74752.0 75668.0 12330.2 12875.4 14496.8 14922.6 21115.7 23764.4 23927.3 24251.0 24815.6 24850.3 18551.2 18687.3 19273.8 19379.2 19426.8 16201.8 16400.8 16868.3 17077.1 18041.1 19223.2 19281.6 19539.6 19826.9 19849.8 20743.0 20758.9 20770.0 20803.6 20860.7 16929.4 19097.0 19231.7 19240.3 19685.5 14:11:59 INFO - PID 9969 | 14:11:59 INFO - PID 9969 | [#3] mootools.html Cycles:180 Average:9325.97 Median:2680.03 stddev:6661.14 (248.5%) stddev-sans-first:6652.78 14:11:59 INFO - PID 9969 | Values: 1337.0 1375.5 1402.2 1402.7 1403.4 12441.3 14956.6 15488.7 15556.4 15585.3 12501.4 14820.4 15360.7 15393.6 15410.2 2746.6 2807.6 2808.0 2810.4 2812.1 2711.5 2802.3 2802.8 2803.0 2804.4 2761.1 2782.7 2783.5 2786.1 2794.4 2664.3 2695.8 2698.2 2701.4 2703.1 2630.0 2645.9 2648.9 2651.6 2660.5 14613.9 14875.9 14892.1 14897.9 14903.2 7949.9 8254.2 8260.5 8265.0 8265.2 4902.6 5171.0 5322.5 5327.4 5500.9 1771.4 1840.6 1871.6 1881.0 1881.5 25972.5 25993.4 26032.9 26044.9 26095.0 7289.6 7312.3 7324.9 7393.4 7409.4 19329.9 19423.6 19446.1 19467.4 19472.2 8140.2 8153.1 8168.1 8172.9 8179.6 5933.7 6111.7 6284.2 7287.8 7308.5 5558.1 5702.5 5729.7 5777.0 5840.8 1811.5 1822.6 1838.7 1846.4 1876.1 881.2 892.8 896.6 902.9 910.1 8381.5 8489.7 8566.3 8645.9 8693.5 723.1 726.2 727.5 729.9 734.6 4368.6 4402.9 4407.3 4471.2 4485.8 20134.6 21068.5 21102.4 21109.4 21116.4 19804.3 21061.0 21069.8 21071.7 21112.4 10943.2 10962.7 11265.7 11267.6 11296.2 8449.5 8797.8 8827.2 8830.1 8842.7 18508.5 18809.2 19170.9 19228.8 19439.3 18745.3 19005.2 19129.8 19280.1 19473.8 11688.5 11907.8 11960.8 11960.9 11962.2 13963.7 13972.6 14063.2 14087.9 14092.7 11446.7 11624.5 11650.1 11819.4 11921.5 10493.1 10719.1 10735.3 10821.6 11003.8 9241.2 9398.2 9432.3 9493.7 9513.6 6255.4 6398.6 6430.8 6447.5 6554.5 7183.2 7254.1 7333.6 7355.9 7374.2 14:11:59 INFO - PID 9969 | 14:11:59 INFO - PID 9969 | [#4] prototype.html Cycles:180 Average:5509.97 Median:6168.65 stddev:1542.50 (25.0%) stddev-sans-first:1500.25 14:11:59 INFO - PID 9969 | Values: 497.5 509.1 522.1 528.0 528.6 6203.2 6283.6 6300.3 6348.8 6384.0 6224.2 6269.5 6276.0 6285.9 6311.9 5145.4 5171.3 5174.4 5185.9 5227.2 4750.2 5118.9 5144.8 5185.5 5198.6 4836.8 4907.1 4952.2 4956.8 4961.7 4898.5 4911.9 4939.9 4976.0 4991.0 4335.1 4409.1 4423.0 4449.1 4480.8 6014.3 6015.4 6083.6 6099.5 6134.1 5615.2 5674.7 5689.4 5729.6 5735.4 6588.9 6605.9 6606.3 6612.4 6630.4 4869.2 4872.6 4885.4 4890.1 4891.2 6585.5 6679.5 6757.7 6788.6 6852.6 4962.8 4988.0 4996.5 4996.9 5015.0 5062.0 5067.8 5073.6 5084.7 5092.0 5613.4 5642.7 5654.9 5663.7 5715.2 6631.8 6642.8 6643.7 6670.2 6689.4 1745.8 1765.2 1769.0 1773.0 1775.3 1152.3 1199.3 1218.6 1228.0 1229.4 5644.9 5766.4 5787.3 5792.2 5800.2 6647.0 6681.2 6707.3 6727.9 6728.2 5639.9 5641.2 5734.4 5743.5 5768.2 3494.0 3529.6 3544.8 3549.9 3576.8 6421.4 6473.2 6489.2 6510.2 6555.0 6859.5 6863.0 6880.9 6895.8 6900.5 5934.4 6252.3 6265.6 6401.0 6448.8 6579.0 6622.2 6658.8 6680.7 6695.8 6534.2 6562.7 6639.9 6654.5 6694.5 6544.6 6548.6 6568.6 6596.4 6611.6 5007.5 5033.0 5033.8 5042.9 5072.2 6514.4 6626.4 6668.9 6813.5 6827.7 6355.2 6496.7 6540.0 6577.1 6597.9 6477.6 6499.8 6513.7 6551.7 6558.0 6481.4 6488.7 6491.4 6495.5 6502.5 6525.0 6588.9 6637.8 6649.6 6654.4 6232.5 6325.6 6382.9 6398.7 6410.6 14:11:59 INFO - PID 9969 | 14:11:59 INFO - PID 9969 | [#5] yui.html Cycles:180 Average:23600.76 Median:18952.19 stddev:32192.22 (169.9%) stddev-sans-first:32237.43 14:11:59 INFO - PID 9969 | Values: 909.1 918.7 929.1 929.7 934.3 17976.0 18835.6 18903.1 19001.2 22192.4 19493.2 19512.8 19764.6 19765.8 19769.3 704.4 715.4 937.8 944.8 945.1 1000.1 1000.7 1001.2 1002.3 1002.8 1038.0 1044.9 1045.4 1046.2 1050.2 1036.3 1041.7 1045.1 1045.3 1049.0 764.9 766.5 769.1 769.8 770.5 17913.5 18111.6 18235.5 19147.5 20107.8 21195.8 21427.0 21832.2 21832.8 21896.0 16409.2 16643.9 16754.5 16763.4 16894.9 3708.4 3720.0 3722.7 3726.5 3727.0 121683.0 124904.4 125327.0 126386.0 127774.0 16895.3 17270.4 17548.7 17593.0 17628.0 29907.7 30637.5 30915.7 31247.0 31266.8 8592.1 8672.4 8688.1 8696.1 8709.9 3519.4 3532.0 3756.0 3801.8 4183.1 4948.9 5082.0 5085.9 5088.1 5102.9 1072.9 1095.8 1106.3 1117.6 1118.6 581.9 612.9 627.6 629.4 650.6 10843.3 11739.1 11874.2 12189.5 12206.6 605.7 606.0 631.1 646.8 653.1 5566.8 5627.0 5667.0 6039.4 6240.8 107749.0 107753.0 108251.9 112192.0 112209.0 93694.0 94440.5 95450.0 96718.5 97104.0 85912.1 86254.0 89687.6 90280.5 91033.0 11612.4 11772.2 12398.1 12482.3 12496.6 41103.4 41575.6 41808.4 42166.2 42780.0 68977.0 70436.6 72736.1 73887.6 77579.6 15828.3 16096.8 16116.2 16119.4 16177.8 16572.9 17583.1 17699.0 17769.6 18197.5 17480.6 17716.7 18000.3 18032.5 18239.6 17626.6 17703.6 17711.7 17830.7 18230.7 16625.4 16880.9 16942.9 17032.5 17186.3 12096.2 12412.8 12587.0 12770.8 13009.3 13689.5 13996.4 14018.2 14067.8 14210.1 14:11:59 INFO - PID 9969 | -------- Summary: end -------- 14:11:59 INFO - PID 9969 | 14:12:00 INFO - TEST-INFO | 9969: exit 0 14:12:00 INFO - TEST-OK | dromaeo_css | took 1111270ms 14:12:00 INFO - TEST-START | kraken 14:12:00 INFO - Initialising browser for kraken test... 14:12:00 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:56408/getInfo.html -profile /tmp/tmpQ15uvE/profile 14:12:00 INFO - TEST-INFO | started process 10349 (/builds/slave/test/build/application/firefox/firefox http://localhost:56408/getInfo.html) 14:12:05 INFO - TEST-INFO | 10349: exit 0 14:12:05 INFO - Browser initialized. 14:12:05 INFO - Running cycle 1/1 for kraken test... 14:12:05 INFO - Using env: {'DISPLAY': ':0', 14:12:05 INFO - 'HOME': '/home/cltbld', 14:12:05 INFO - 'JSGC_DISABLE_POISONING': '1', 14:12:05 INFO - 'LANG': 'en_US.UTF-8', 14:12:05 INFO - 'LANGUAGE': 'en_US:en', 14:12:05 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 14:12:05 INFO - 'LOGNAME': 'cltbld', 14:12:05 INFO - 'MAIL': '/var/mail/cltbld', 14:12:05 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:12:05 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 14:12:05 INFO - 'MOZ_CRASHREPORTER': '1', 14:12:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:12:05 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 14:12:05 INFO - 'MOZ_NO_REMOTE': '1', 14:12:05 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:12:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:12:05 INFO - 'NO_EM_RESTART': '1', 14:12:05 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:12:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:12:05 INFO - 'PWD': '/builds/slave/test', 14:12:05 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:12:05 INFO - 'RUST_BACKTRACE': 'full', 14:12:05 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 14:12:05 INFO - 'SHELL': '/bin/bash', 14:12:05 INFO - 'SHLVL': '1', 14:12:05 INFO - 'STYLO_FORCE_ENABLED': '1', 14:12:05 INFO - 'TERM': 'linux', 14:12:05 INFO - 'TMOUT': '86400', 14:12:05 INFO - 'USER': 'cltbld', 14:12:05 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1504212301.368790-1415861466', 14:12:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:12:05 INFO - '_': '/tools/buildbot/bin/python'} 14:12:05 INFO - TEST-INFO | started process 10546 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQ15uvE/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 14:12:06 INFO - PID 10546 | 14:12:06 INFO - PID 10546 | (/builds/slave/test/build/application/firefox/firefox:10597): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 14:12:06 INFO - PID 10546 | 14:12:16 INFO - PID 10546 | RSS: Main: 172916736 14:12:16 INFO - PID 10546 | 14:12:19 INFO - PID 10546 | Cycle 1(1): loaded http://localhost:56408/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56408/tests/kraken/driver.html?testName=audio-beat-detection) 14:12:20 INFO - PID 10546 | RSS: Main: 179068928 14:12:20 INFO - PID 10546 | 14:12:23 INFO - PID 10546 | Cycle 1(1): loaded http://localhost:56408/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56408/tests/kraken/driver.html?testName=audio-dft) 14:12:23 INFO - PID 10546 | RSS: Main: 182906880 14:12:23 INFO - PID 10546 | 14:12:26 INFO - PID 10546 | Cycle 1(1): loaded http://localhost:56408/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56408/tests/kraken/driver.html?testName=audio-fft) 14:12:27 INFO - PID 10546 | RSS: Main: 174854144 14:12:27 INFO - PID 10546 | 14:12:29 INFO - PID 10546 | Cycle 1(1): loaded http://localhost:56408/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56408/tests/kraken/driver.html?testName=audio-oscillator) 14:12:30 INFO - PID 10546 | RSS: Main: 175104000 14:12:30 INFO - PID 10546 | 14:12:32 INFO - PID 10546 | Cycle 1(1): loaded http://localhost:56408/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56408/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:12:33 INFO - PID 10546 | RSS: Main: 175656960 14:12:33 INFO - PID 10546 | 14:12:36 INFO - PID 10546 | Cycle 1(1): loaded http://localhost:56408/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56408/tests/kraken/driver.html?testName=imaging-darkroom) 14:12:36 INFO - PID 10546 | RSS: Main: 176779264 14:12:36 INFO - PID 10546 | 14:12:40 INFO - PID 10546 | Cycle 1(1): loaded http://localhost:56408/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56408/tests/kraken/driver.html?testName=imaging-desaturate) 14:12:40 INFO - PID 10546 | RSS: Main: 176730112 14:12:40 INFO - PID 10546 | 14:12:43 INFO - PID 10546 | Cycle 1(1): loaded http://localhost:56408/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56408/tests/kraken/driver.html?testName=json-parse-financial) 14:12:44 INFO - PID 10546 | RSS: Main: 176799744 14:12:44 INFO - PID 10546 | 14:12:45 INFO - PID 10546 | Cycle 1(1): loaded http://localhost:56408/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56408/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:12:46 INFO - PID 10546 | RSS: Main: 176168960 14:12:46 INFO - PID 10546 | 14:12:48 INFO - PID 10546 | Cycle 1(1): loaded http://localhost:56408/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56408/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:12:48 INFO - PID 10546 | RSS: Main: 176967680 14:12:48 INFO - PID 10546 | 14:12:50 INFO - PID 10546 | Cycle 1(1): loaded http://localhost:56408/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56408/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:12:51 INFO - PID 10546 | RSS: Main: 173518848 14:12:51 INFO - PID 10546 | 14:12:54 INFO - PID 10546 | Cycle 1(1): loaded http://localhost:56408/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56408/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:12:55 INFO - PID 10546 | RSS: Main: 173641728 14:12:55 INFO - PID 10546 | 14:12:57 INFO - PID 10546 | Cycle 1(1): loaded http://localhost:56408/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56408/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:12:58 INFO - PID 10546 | RSS: Main: 173596672 14:12:58 INFO - PID 10546 | 14:13:00 INFO - PID 10546 | Cycle 1(1): loaded http://localhost:56408/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56408/tests/kraken/driver.html?testName=ai-astar) 14:13:00 INFO - PID 10546 | RSS: Main: 175538176 14:13:00 INFO - PID 10546 | 14:13:00 INFO - PID 10546 | __start_tp_report 14:13:00 INFO - PID 10546 | _x_x_mozilla_page_load 14:13:00 INFO - PID 10546 | _x_x_mozilla_page_load_details 14:13:00 INFO - PID 10546 | |i|pagename|runs| 14:13:00 INFO - PID 10546 | |0;ai-astar;97;109;100;106;106;113;107;99;110;107 14:13:00 INFO - PID 10546 | |1;audio-beat-detection;144;117;145;181;117;148;142;117;176;128 14:13:00 INFO - PID 10546 | |2;audio-dft;162;161;162;164;165;164;165;167;166;164 14:13:00 INFO - PID 10546 | |3;audio-fft;74;82;74;173;74;74;74;89;95;75 14:13:00 INFO - PID 10546 | |4;audio-oscillator;79;80;128;79;86;79;145;79;80;124 14:13:00 INFO - PID 10546 | |5;imaging-gaussian-blur;113;113;114;114;113;114;114;114;114;115 14:13:00 INFO - PID 10546 | |6;imaging-darkroom;148;150;149;148;148;148;147;148;148;150 14:13:00 INFO - PID 10546 | |7;imaging-desaturate;99;94;94;94;95;94;94;94;95;95 14:13:00 INFO - PID 10546 | |8;json-parse-financial;52;54;53;52;52;53;53;52;52;52 14:13:00 INFO - PID 10546 | |9;json-stringify-tinderbox;38;38;38;38;38;39;38;38;38;39 14:13:00 INFO - PID 10546 | |10;stanford-crypto-aes;74;77;74;74;72;79;74;78;77;75 14:13:00 INFO - PID 10546 | |11;stanford-crypto-ccm;122;126;119;120;128;126;120;120;119;172 14:13:00 INFO - PID 10546 | |12;stanford-crypto-pbkdf2;170;171;170;168;180;175;181;169;180;170 14:13:00 INFO - PID 10546 | |13;stanford-crypto-sha256-iterative;67;66;65;65;62;69;67;65;64;62 14:13:00 INFO - PID 10546 | __end_tp_report 14:13:00 INFO - PID 10546 | __start_cc_report 14:13:00 INFO - PID 10546 | _x_x_mozilla_cycle_collect,960 14:13:00 INFO - PID 10546 | __end_cc_report 14:13:00 INFO - PID 10546 | __startTimestamp1504213980624__endTimestamp 14:13:00 INFO - PID 10546 | 14:13:00 INFO - PID 10546 | ------- Summary: start ------- 14:13:00 INFO - PID 10546 | Number of tests: 14 14:13:00 INFO - PID 10546 | 14:13:00 INFO - PID 10546 | [#0] ai-astar Cycles:10 Average:105.40 Median:109.50 stddev:5.15 (4.7%) stddev-sans-first:4.47 14:13:00 INFO - PID 10546 | Values: 97.0 109.0 100.0 106.0 106.0 113.0 107.0 99.0 110.0 107.0 14:13:00 INFO - PID 10546 | 14:13:00 INFO - PID 10546 | [#1] audio-beat-detection Cycles:10 Average:141.50 Median:144.50 stddev:23.08 (16.0%) stddev-sans-first:24.46 14:13:00 INFO - PID 10546 | Values: 144.0 117.0 145.0 181.0 117.0 148.0 142.0 117.0 176.0 128.0 14:13:00 INFO - PID 10546 | 14:13:00 INFO - PID 10546 | [#2] audio-dft Cycles:10 Average:164.00 Median:164.50 stddev:1.89 (1.1%) stddev-sans-first:1.86 14:13:00 INFO - PID 10546 | Values: 162.0 161.0 162.0 164.0 165.0 164.0 165.0 167.0 166.0 164.0 14:13:00 INFO - PID 10546 | 14:13:00 INFO - PID 10546 | [#3] audio-fft Cycles:10 Average:88.40 Median:74.50 stddev:30.66 (41.1%) stddev-sans-first:32.07 14:13:00 INFO - PID 10546 | Values: 74.0 82.0 74.0 173.0 74.0 74.0 74.0 89.0 95.0 75.0 14:13:00 INFO - PID 10546 | 14:13:00 INFO - PID 10546 | [#4] audio-oscillator Cycles:10 Average:95.90 Median:79.00 stddev:25.77 (32.6%) stddev-sans-first:26.60 14:13:00 INFO - PID 10546 | Values: 79.0 80.0 128.0 79.0 86.0 79.0 145.0 79.0 80.0 124.0 14:13:00 INFO - PID 10546 | 14:13:00 INFO - PID 10546 | [#5] imaging-gaussian-blur Cycles:10 Average:113.80 Median:114.00 stddev:0.63 (0.6%) stddev-sans-first:0.60 14:13:00 INFO - PID 10546 | Values: 113.0 113.0 114.0 114.0 113.0 114.0 114.0 114.0 114.0 115.0 14:13:00 INFO - PID 10546 | 14:13:00 INFO - PID 10546 | [#6] imaging-darkroom Cycles:10 Average:148.40 Median:148.00 stddev:0.97 (0.7%) stddev-sans-first:1.01 14:13:00 INFO - PID 10546 | Values: 148.0 150.0 149.0 148.0 148.0 148.0 147.0 148.0 148.0 150.0 14:13:00 INFO - PID 10546 | 14:13:00 INFO - PID 10546 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:94.50 stddev:1.55 (1.6%) stddev-sans-first:0.50 14:13:00 INFO - PID 10546 | Values: 99.0 94.0 94.0 94.0 95.0 94.0 94.0 94.0 95.0 95.0 14:13:00 INFO - PID 10546 | 14:13:00 INFO - PID 10546 | [#8] json-parse-financial Cycles:10 Average:52.50 Median:52.50 stddev:0.71 (1.3%) stddev-sans-first:0.73 14:13:00 INFO - PID 10546 | Values: 52.0 54.0 53.0 52.0 52.0 53.0 53.0 52.0 52.0 52.0 14:13:00 INFO - PID 10546 | 14:13:00 INFO - PID 10546 | [#9] json-stringify-tinderbox Cycles:10 Average:38.20 Median:38.00 stddev:0.42 (1.1%) stddev-sans-first:0.44 14:13:00 INFO - PID 10546 | Values: 38.0 38.0 38.0 38.0 38.0 39.0 38.0 38.0 38.0 39.0 14:13:00 INFO - PID 10546 | 14:13:00 INFO - PID 10546 | [#10] stanford-crypto-aes Cycles:10 Average:75.40 Median:76.00 stddev:2.22 (2.9%) stddev-sans-first:2.30 14:13:00 INFO - PID 10546 | Values: 74.0 77.0 74.0 74.0 72.0 79.0 74.0 78.0 77.0 75.0 14:13:00 INFO - PID 10546 | 14:13:00 INFO - PID 10546 | [#11] stanford-crypto-ccm Cycles:10 Average:127.20 Median:124.00 stddev:16.08 (13.0%) stddev-sans-first:16.95 14:13:00 INFO - PID 10546 | Values: 122.0 126.0 119.0 120.0 128.0 126.0 120.0 120.0 119.0 172.0 14:13:00 INFO - PID 10546 | 14:13:00 INFO - PID 10546 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:173.40 Median:173.00 stddev:5.13 (3.0%) stddev-sans-first:5.29 14:13:00 INFO - PID 10546 | Values: 170.0 171.0 170.0 168.0 180.0 175.0 181.0 169.0 180.0 170.0 14:13:00 INFO - PID 10546 | 14:13:00 INFO - PID 10546 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.20 Median:65.50 stddev:2.20 (3.4%) stddev-sans-first:2.24 14:13:00 INFO - PID 10546 | Values: 67.0 66.0 65.0 65.0 62.0 69.0 67.0 65.0 64.0 62.0 14:13:00 INFO - PID 10546 | -------- Summary: end -------- 14:13:00 INFO - PID 10546 | 14:13:01 INFO - PID 10546 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 14:13:01 INFO - TEST-INFO | 10546: exit 0 14:13:01 INFO - TEST-OK | kraken | took 60777ms 14:13:01 INFO - SUITE-END | took 1172s 14:13:01 INFO - Completed test suite (00:19:32) 14:13:01 INFO - javascript benchmark 14:13:01 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8546.254775038944, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3300.042987533614, 3318.1870441741776, 3326.800391976481, 3349.330133973206, 3352.463605823069, 6282.528810339231, 6316.399942005508, 6371.426571608555, 6380.680965951707, 6394.1367915331475, 6228.0, 6324.652144132071, 6326.968365158179, 6333.429991300782, 6339.302676705559, 5773.971130144354, 5792.131180322943, 5806.10005449154, 5809.477147056764, 5843.0, 5832.708364581775, 5871.677057761843, 5908.02517584598, 5963.344032156459, 5978.8206353809455, 5850.619709718876, 5923.14114453404, 5937.317208521011, 5988.610740301889, 5992.940070599304, 5680.4319568043275, 5753.827385178452, 5802.825915222508, 5870.884531938918, 5892.764289428418, 5639.0, 5771.047777116771, 5772.278465191851, 5867.941320586782, 5884.558658100659, 6233.0, 6343.333949935237, 6375.2987171411105, 6383.808485745389, 6391.77628782995, 6674.365935236145, 6730.326967303279, 6736.5958042517605, 6759.662016899185, 6778.864422711518, 6891.689873955684, 6905.620190889499, 6910.343517365842, 6917.688704008332, 6931.653417329164, 6359.745610175587, 6376.617402955838, 6413.6793160341795, 6442.226932768098, 6451.451626611697, 7013.123359580052, 7068.646567671596, 7137.785866424016, 7142.357187853118, 7159.284071592799, 6471.449926756279, 6539.215294164635, 6584.374484423972, 6616.834579135464, 6721.327867213239, 6759.459243260528, 6760.830979225559, 6761.0, 6768.086308348408, 6775.93224067753, 6709.329067093252, 6744.494162937701, 6753.223379311442, 6765.594064356154, 6771.4582833373215, 6754.5947243165565, 6771.322867713189, 6776.11910451648, 6784.966075169593, 6788.287229840895, 5278.181881808326, 5287.259783630295, 5292.841214763486, 5300.893982120413, 5316.0, 4610.193216187221, 4688.976555117202, 4693.741844198602, 4696.647751418589, 4717.24524076153, 5720.599558030898, 5775.0, 5889.028310328834, 5894.2926848778425, 5974.3428222895445, 6743.460523158135, 6745.696443660047, 6773.627450490172, 6815.2843951385385, 6825.35159159879, 5944.138099975479, 5962.612430192024, 5963.224780778471, 5965.403459654, 5971.940280597139, 5826.912596311059, 5832.825015249549, 5868.295804503487, 5868.295804503487, 5881.764729410861, 6569.277379488252, 6631.171103612145, 6658.966705166443, 6661.467082633378, 6666.333366663392, 6774.220964589135, 6778.356056174655, 6789.388954994074, 6879.484038697218, 6892.586444813327, 6433.453156481752, 6500.122483464672, 6516.837079073061, 6576.145101137013, 6657.600543967377, 6681.532292739462, 6695.564788288746, 6719.361660642231, 6742.69657865407, 6791.72833086671, 6835.58986460814, 6866.279040700854, 6923.065386173003, 6934.410575100971, 6944.0, 6577.835554110994, 6607.141071660653, 6617.404433600999, 6712.328767123248, 6712.6979285931275, 6605.933940660724, 6643.667816609247, 6665.633390163587, 6668.266490686117, 6672.132622759011, 6546.672666366568, 6558.737650494118, 6602.10871532337, 6638.336166383323, 6638.90041649366, 6660.134182556237, 6677.131972843499, 6679.699413526306, 6729.461643068445, 6770.119884414995, 6191.690415479298, 6290.905636415366, 6375.553711240169, 6518.413342799171, 6544.574602650812], "value": 6208.157572832765, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [819.1439945257206, 860.1570460948271, 884.0938038510526, 886.9423487473314, 1135.0579019413876, 37316.44025339622, 40888.0, 40938.59061409389, 40976.18047639045, 40977.59022409775, 40320.59679403205, 41174.38238426426, 41542.37686434706, 41633.0, 41642.0, 7747.961260193705, 7875.606219689022, 7876.0, 7925.128235894047, 7927.3658107351275, 7762.0, 7842.294193522582, 7859.960700196491, 7860.842783144362, 7863.292303692667, 7856.646450909694, 7861.21387861215, 7890.289873911347, 7894.921050789476, 7918.129005809356, 7852.489588176751, 7868.134505204423, 7874.251946065115, 7877.4485785995, 7894.526328420285, 7736.110347310075, 7764.767056988299, 7801.0638723352995, 7821.100573434014, 7822.843543129163, 37666.43500347497, 37723.811380943196, 37734.0, 37772.62227377718, 37947.43078853819, 3530.0, 3560.2701446203723, 3566.0, 3566.7503274770775, 3576.946345804815, 31097.844510777526, 31295.06114816559, 31348.37303253922, 31425.0, 31445.685543144733, 5053.469385714484, 5222.843314700565, 5234.241035049935, 5266.4733526647415, 5299.417064122943, 183135.0, 183454.0, 183551.0, 184015.0, 184528.0, 46208.07583848304, 46572.0, 46826.29760553595, 46949.29576056362, 47067.0, 52984.0, 53834.19248711273, 53936.46063539393, 54008.189877151875, 54150.729246354305, 13199.47202111924, 13479.123856949267, 15106.773398399033, 15158.621034474007, 15420.228988550753, 12283.0, 12411.193272437444, 12421.75156496883, 12438.564650237198, 12448.564300249629, 14306.141631502143, 14372.20347456568, 14378.856211437751, 14480.927595361956, 14584.0, 5804.332501762267, 5822.737976791054, 5847.356790753014, 5907.143464197753, 5924.822255332347, 1005.6631028605499, 1010.1918465227789, 1011.175891648319, 1014.2950649298666, 1017.2878984710732, 22755.658665120038, 22806.885965570396, 22951.655725164135, 22962.19632312861, 22991.54016919686, 1099.5107177306181, 1111.1943840715578, 1113.7438389170536, 1117.958579734271, 1126.189143816451, 12126.696832579257, 12228.938855305667, 12255.571055013032, 12265.632031039084, 12278.693032674255, 235682.0, 237097.0, 237400.0, 237433.0, 237555.0, 51284.48715512797, 51586.48413515817, 51599.48400516022, 51675.0, 51689.483105169216, 1424.8005279260913, 1462.926853657313, 1478.068816645528, 1484.5101116631486, 1495.53638372105, 22264.66603000989, 22295.331140065824, 22405.887970560696, 22459.32622021342, 22933.197338093752, 37763.24473510569, 37785.433218501195, 37824.24351512899, 37962.0, 37994.62005379911, 190067.0, 190302.0, 190327.0, 190874.0, 191038.0, 32745.18137046593, 33820.83089584536, 34110.829445852614, 34168.48747268843, 34218.657813421545, 41655.1668966625, 41880.79059604683, 42078.36882446827, 45849.0, 46228.768856155504, 33055.83472082624, 33354.83322583372, 33453.16367090842, 33762.15594610056, 33849.15377115592, 32950.50574241341, 33231.33537329288, 33364.83317583494, 33764.83117584397, 33861.153471163416, 37413.0, 37491.43762843505, 37759.0, 37779.244415112094, 38073.4288985671, 32678.673213267564, 33069.33861322712, 33196.33607327888, 33234.83382583072, 33269.50095748614, 23975.76024239735, 24092.036318547063, 24296.1496347627, 24441.633375499736, 24737.0], "value": 17231.71520969909, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [565.9179418984245, 569.8091139468278, 570.623388563548, 571.611304313067, 577.99711001445, 22199.44501387466, 22297.331080067604, 23249.535009299805, 23302.65046024307, 23308.533829323445, 24998.375040623992, 25414.36464088399, 25461.872690636566, 25500.74499255007, 25535.0, 6586.506012049092, 6741.157355330583, 6742.561733487332, 6760.1549806274215, 6760.695768690396, 6053.273607167146, 6592.637404942726, 6622.73509059637, 6625.17185351831, 6652.567583107107, 6578.440832529241, 6594.1427614410295, 6594.571352862049, 6603.14159159311, 6618.602883826961, 6611.834704132387, 6618.569792963442, 6618.569792963466, 6619.5035372347265, 6622.53642245043, 6126.23422072241, 6128.877422451526, 6143.078538219258, 6143.692815359259, 6146.108814221958, 27810.860945695345, 28520.0, 29106.0, 29107.0, 29284.707152928626, 2007.036622421246, 2029.9391018269475, 2031.0149577454922, 2032.9796702032938, 2033.4204751645857, 19291.0, 19901.701474477893, 19916.900415497974, 19943.102560384672, 19949.601007979905, 2357.39886328985, 2364.4443555764383, 2382.3686723018413, 2411.1801987324393, 2476.418041760185, 128083.0, 135752.0, 135759.0, 136054.31972840172, 136276.0, 13955.930220348833, 14886.404543818342, 14955.812372535707, 15026.924865375822, 15419.0, 22525.324240272817, 22623.66064509034, 22695.546089078125, 22723.318300451014, 22740.772592274196, 9957.950210249048, 10020.142245235636, 10082.24383171265, 10125.443100629536, 10126.645567405105, 7666.769996900102, 9200.30997675177, 9240.168384845396, 9268.165865072177, 9277.67528136512, 7839.529628222325, 9178.21985131258, 9178.449293042439, 9355.812883742286, 9439.224310275944, 2700.3519155402564, 2726.768224700883, 2731.740484653955, 2757.6415066041286, 2858.099698594936, 970.9951450242703, 975.1662328708993, 989.3717489394143, 991.509202944547, 999.8300288950895, 19043.42869713911, 19562.51093722668, 20072.0, 20173.798262017193, 20388.28640997558, 1040.9167266618651, 1041.7812259425455, 1042.207921979301, 1044.5926088825365, 1059.3961441978154, 10669.199810014125, 10876.347419154876, 11076.11391088711, 11080.667579972614, 11203.439828008566, 471889.0, 479588.0, 483570.0, 485399.0, 487395.0, 103057.48471257745, 104828.0, 109968.4501577487, 110288.4485577567, 112588.43705781418, 1153.8038533449335, 1175.9941200293945, 1193.1945936493007, 1193.886580774825, 1202.3086725133082, 16865.578360541083, 17047.91476042612, 17333.47999560015, 17572.648547028733, 17666.5583360417, 53471.177320512805, 54985.450145498035, 55038.449615504935, 55071.0, 57385.426145738005, 66936.66531667311, 71151.0, 74597.62701186459, 74752.0, 75668.0, 12330.19853709506, 12875.420606072561, 14496.782548261996, 14922.626934326729, 21115.683264751347, 23764.405889852893, 23927.28218153458, 24251.0, 24815.627765583893, 24850.254492365257, 18551.16519756587, 18687.345942891934, 19273.807261927202, 19379.224831006602, 19426.805731943066, 16201.75697364517, 16400.75398868994, 16868.325266989184, 17077.146142692567, 18041.097945102956, 19223.231070757014, 19281.61436771285, 19539.609207816047, 19826.90086549558, 19849.801501984795, 20743.0, 20758.896205518875, 20770.0, 20803.583928321044, 20860.68708969397, 16929.407470738464, 19097.0, 19231.711524327427, 19240.326588569333, 19685.507862302984], "value": 12098.326933625742, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1336.9799453008204, 1375.5185685010247, 1402.193738600305, 1402.6843960108974, 1403.3825116948549, 12441.253524788519, 14956.551303460887, 15488.690226195484, 15556.377744890206, 15585.29866156023, 12501.43743531541, 14820.40718371264, 15360.692786144271, 15393.614574688276, 15410.229488525585, 2746.6292050573165, 2807.6490438695164, 2807.985960070207, 2810.3536186676974, 2812.057960583207, 2711.4712631036955, 2802.285417218606, 2802.845843478608, 2802.985985070072, 2804.4250928559595, 2761.1164427383146, 2782.7217278272215, 2783.485055264772, 2786.0527420676967, 2794.413173233623, 2664.267326485213, 2695.7978151638704, 2698.2040298112006, 2701.419194873102, 2703.080952476148, 2630.040035387089, 2645.854478003709, 2648.894044238228, 2651.64202832619, 2660.4546068056, 14613.926930365387, 14875.925620371938, 14892.106473611619, 14897.925510372486, 14903.180325082116, 7949.920500795034, 8254.174582541698, 8260.504369737835, 8265.0, 8265.214804593554, 4902.607791376681, 5171.0, 5322.547583455411, 5327.387350454708, 5500.889982200333, 1771.446515174923, 1840.6226723521645, 1871.5695390060225, 1880.9717854232197, 1881.4543782303115, 25972.480550389075, 25993.350166245807, 26032.8698356507, 26044.869775651, 26095.0, 7289.635518224173, 7312.341889229995, 7324.926750732425, 7393.445491588045, 7409.444291678145, 19329.903350483157, 19423.611527769648, 19446.124924378437, 19467.415977520697, 19472.221111155395, 8140.226678465537, 8153.062397824327, 8168.142345053802, 8172.918270817335, 8179.591020449073, 5933.732982015819, 6111.694415279218, 6284.214473190851, 7287.817804554928, 7308.524945878501, 5558.082916318843, 5702.515286200636, 5729.713514324267, 5776.971115144482, 5840.8247752567495, 1811.501836994837, 1822.6081392500676, 1838.7241913712783, 1846.4368367647996, 1876.052593440304, 881.2377293640955, 892.7544925145637, 896.5741272895323, 902.8871391076116, 910.1308250620641, 8381.49711017341, 8489.70286039998, 8566.3146948244, 8645.870311945326, 8693.478391296543, 723.1141851232198, 726.1612837173074, 727.4980263618087, 729.8576777528331, 734.566605702638, 4368.628666563314, 4402.8679139625865, 4407.294832826732, 4471.217536931089, 4485.753283569435, 20134.597308053755, 21068.47328816792, 21102.366928992156, 21109.366718998455, 21116.366509004754, 19804.306849260207, 21061.0, 21069.78930210709, 21071.68392474114, 21112.366629001153, 10943.179261555415, 10962.671119866416, 11265.662030139109, 11267.605633802777, 11296.20926535151, 8449.535275559903, 8797.780055498664, 8827.205551500396, 8830.116988301119, 8842.734717958472, 18508.537286567942, 18809.153588088295, 19170.904145479184, 19228.807711923262, 19439.3196238131, 18745.34391296298, 19005.23979040878, 19129.808701912803, 19280.132394042022, 19473.8052619472, 11688.532458701557, 11907.809219078023, 11960.820587691018, 11960.880391196324, 11962.222455540363, 13963.720725585228, 13972.580822575339, 14063.226522541358, 14087.859121409065, 14092.718145637235, 11446.656600302003, 11624.476898539417, 11650.067994560584, 11819.40902954866, 11921.463534141158, 10493.108085812792, 10719.088877445505, 10735.302205356627, 10821.56713731442, 11003.834942475709, 9241.21449676785, 9398.154166125081, 9432.292578056811, 9493.715188544355, 9513.619455221713, 6255.437010669061, 6398.648074355955, 6430.839229019312, 6447.516436267392, 6554.4756419485375, 7183.20984691673, 7254.093238345207, 7333.596652184181, 7355.852882942204, 7374.151972523228], "value": 6646.090746843322, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [497.5053253084392, 509.14463700982344, 522.0993785719631, 527.9762410691519, 528.5824198882883, 6203.193584833971, 6283.575451378998, 6300.30696623371, 6348.80953571393, 6384.0, 6224.19085518883, 6269.467095296905, 6275.968620156893, 6285.882746800841, 6311.905321420182, 5145.382554093495, 5171.276021357013, 5174.379074511064, 5185.896282074356, 5227.2159176123505, 4750.16872047392, 5118.872028199287, 5144.819931302405, 5185.507376799217, 5198.584113270948, 4836.758162091881, 4907.11671899058, 4952.182889823175, 4956.801727930879, 4961.652684312099, 4898.485659005789, 4911.926321105187, 4939.925901111468, 4975.975120124413, 4990.951900100965, 4335.1329734053, 4409.07409444014, 4423.0, 4449.1101779644205, 4480.753558554278, 6014.278286605591, 6015.428534289235, 6083.6045657032155, 6099.512039036911, 6134.110553969694, 5615.213870058195, 5674.659520428788, 5689.431056894319, 5729.5702822288495, 5735.397783232742, 6588.901166482507, 6605.900911486331, 6606.273309935903, 6612.371824676648, 6630.370114839083, 4869.172240719051, 4872.610191184732, 4885.43817460993, 4890.1367919343675, 4891.217405215149, 6585.452418681606, 6679.499037572153, 6757.729690812362, 6788.59268443895, 6852.554583952027, 4962.801487940515, 4988.0, 4996.4503904570465, 4996.925046124311, 5014.974925125424, 5062.0, 5067.771950262247, 5073.590044728798, 5084.669496482717, 5092.0, 5613.382527921925, 5642.6614403135945, 5654.935948378894, 5663.745131469093, 5715.228444160069, 6631.834204144935, 6642.788992292222, 6643.701033453506, 6670.199576050808, 6689.397954184147, 1745.821570439948, 1765.2144795566107, 1769.027035130673, 1772.97340539892, 1775.2810111904698, 1152.262551966742, 1199.2744389644315, 1218.6473014953394, 1227.9815802762967, 1229.3730197599289, 5644.85887852807, 5766.423357664284, 5787.276590426197, 5792.160136780143, 5800.245968024215, 6647.0, 6681.164854393201, 6707.3292670732535, 6727.865442691119, 6728.158980127484, 5639.8590035249445, 5641.153826925994, 5734.426557344315, 5743.54051675865, 5768.221290125864, 3493.9650603494147, 3529.5588051493564, 3544.8404821783083, 3549.8580056797955, 3576.783893476231, 6421.389967953037, 6473.190851143607, 6489.1888513935755, 6510.153680021567, 6554.967225163844, 6859.485538584527, 6862.965685171542, 6880.901325095794, 6895.75864844728, 6900.482463815234, 5934.43622855828, 6252.280987686474, 6265.592736472115, 6401.0, 6448.774292899726, 6578.980258060008, 6622.238442579165, 6658.766943156967, 6680.6993685283305, 6695.832604184934, 6534.170432278969, 6562.671866406565, 6639.933600663931, 6654.536002079535, 6694.4644428444635, 6544.574602650812, 6548.574342667712, 6568.6058836469965, 6596.406323430914, 6611.636360000246, 5007.524285192901, 5033.0, 5033.84898453047, 5042.899142017212, 5072.188449848007, 6514.446272066927, 6626.4096616812585, 6668.933310666831, 6813.523053386215, 6827.726890924308, 6355.173827402408, 6496.707648155939, 6540.0, 6577.14497115372, 6597.868042639025, 6477.578957367756, 6499.837504062436, 6513.73945042193, 6551.70517326731, 6557.967210163919, 6481.4166724994975, 6488.70800813974, 6491.383318584727, 6495.545311828127, 6502.479801615954, 6525.0, 6588.868222635425, 6637.800865974028, 6649.567778094409, 6654.401103900672, 6232.470240029648, 6325.557210995186, 6382.936170638234, 6398.680065996588, 6410.647414392253], "value": 5055.746815169287, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [909.1454033208784, 918.7014220378377, 929.1498279074647, 929.697848199335, 934.2992755433424, 17976.0, 18835.623287534276, 18903.149358278857, 19001.239950401985, 22192.445188870286, 19493.220271189137, 19512.804871951277, 19764.604707905833, 19765.802341976578, 19769.308074217406, 704.4258928972896, 715.3633266392915, 937.779621788879, 944.7874228298613, 945.1493655709882, 1000.0799264676479, 1000.6747806962729, 1001.2140469731262, 1002.3334482569082, 1002.8194924913513, 1037.9636712715057, 1044.9111825494842, 1045.3571053801934, 1046.2257929132425, 1050.2333296693419, 1036.3004971644186, 1041.6927006533092, 1045.1325399918087, 1045.3362115056955, 1048.958041678332, 764.900562926816, 766.5324152267112, 769.0924708843562, 769.7536788227769, 770.5107256891858, 17913.462596122135, 18111.63776724458, 18235.54411139719, 19147.52131196717, 20107.798922010737, 21195.78804211969, 21427.0, 21832.23587174441, 21832.781672183235, 21896.0, 16409.179541022902, 16643.91678041614, 16754.497365079067, 16763.413280535246, 16894.915525422293, 3708.4251940948925, 3719.9628003719886, 3722.720795940288, 3726.4782930389765, 3726.981365093184, 121683.0, 124904.37547812294, 125326.99999999908, 126385.99999999908, 127774.0, 16895.32418703238, 17270.395536156426, 17548.73676894822, 17593.0, 17628.0, 29907.70092299049, 30637.540436893465, 30915.69084309128, 31247.0, 31266.843665781525, 8592.097829727914, 8672.436291641023, 8688.087750786077, 8696.130386961253, 8709.91290087091, 3519.4017017107153, 3532.0, 3755.981220093937, 3801.82891769871, 4183.100633363781, 4948.8762780930765, 5082.034413461431, 5085.923711144335, 5088.0587091388215, 5102.923456148086, 1072.8605281313535, 1095.8356246562919, 1106.3251416635846, 1117.6311817100338, 1118.5749415222162, 581.8748968971606, 612.9141920131185, 627.5575719118011, 629.3549112160073, 650.6291413894035, 10843.295185812896, 11739.11956603241, 11874.228175168586, 12189.451474683661, 12206.633800985985, 605.7455868535226, 605.9636421814705, 631.0723236841835, 646.7897933171738, 653.1411194279507, 5566.777328906798, 5626.971865140648, 5666.97166514173, 6039.396060393926, 6240.781572644935, 107749.0, 107753.0, 108251.91748082418, 112192.0, 112209.0, 93694.0, 94440.52779736057, 95450.0, 96718.54922176032, 97104.0, 85912.14087859166, 86254.0, 89687.55156224308, 90280.5485972566, 91033.0, 11612.419379031184, 11772.234804738007, 12398.13213075076, 12482.313472758722, 12496.625101246977, 41103.38344924888, 41575.58424415838, 41808.37287440752, 42166.15667686691, 42780.0, 68977.0, 70436.64781676263, 72736.09055637715, 73887.63056184685, 77579.61210193913, 15828.28772705254, 16096.839031610003, 16116.194190290673, 16119.355225791307, 16177.75733364024, 16572.917135414245, 17583.120843957495, 17699.0, 17769.555761106076, 18197.45407637773, 17480.562985925455, 17716.734248986017, 18000.279988800303, 18032.459026229233, 18239.635207296044, 17626.64746705033, 17703.64592708113, 17711.734323984892, 17830.732539011668, 18230.72653910219, 16625.418110366078, 16880.915595421946, 16942.915285423493, 17032.48902532926, 17186.31254749796, 12096.153269271066, 12412.75174496487, 12587.0, 12770.76511610446, 13009.349532523525, 13689.520866769615, 13996.370163342877, 14018.158910465405, 14067.788983165465, 14210.147391156564], "value": 8959.030245275228, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1484.1000000000001, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 109.0, 100.0, 106.0, 106.0, 113.0, 107.0, 99.0, 110.0, 107.0], "value": 105.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 117.0, 145.0, 181.0, 117.0, 148.0, 142.0, 117.0, 176.0, 128.0], "value": 141.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 162.0, 164.0, 165.0, 164.0, 165.0, 167.0, 166.0, 164.0], "value": 164.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 82.0, 74.0, 173.0, 74.0, 74.0, 74.0, 89.0, 95.0, 75.0], "value": 88.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 80.0, 128.0, 79.0, 86.0, 79.0, 145.0, 79.0, 80.0, 124.0], "value": 95.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 113.0, 114.0, 114.0, 113.0, 114.0, 114.0, 114.0, 114.0, 115.0], "value": 113.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 150.0, 149.0, 148.0, 148.0, 148.0, 147.0, 148.0, 148.0, 150.0], "value": 148.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 94.0, 94.0, 94.0, 95.0, 94.0, 94.0, 94.0, 95.0, 95.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 54.0, 53.0, 52.0, 52.0, 53.0, 53.0, 52.0, 52.0, 52.0], "value": 52.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [38.0, 38.0, 38.0, 38.0, 38.0, 39.0, 38.0, 38.0, 38.0, 39.0], "value": 38.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 77.0, 74.0, 74.0, 72.0, 79.0, 74.0, 78.0, 77.0, 75.0], "value": 75.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [122.0, 126.0, 119.0, 120.0, 128.0, 126.0, 120.0, 120.0, 119.0, 172.0], "value": 127.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 171.0, 170.0, 168.0, 180.0, 175.0, 181.0, 169.0, 180.0, 170.0], "value": 173.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 66.0, 65.0, 65.0, 62.0, 69.0, 67.0, 65.0, 64.0, 62.0], "value": 65.2, "unit": "score"}]}]} 14:13:01 INFO - Return code: 0 14:13:01 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 14:13:01 INFO - # TBPL SUCCESS # 14:13:01 INFO - Running post-action listener: _package_coverage_data 14:13:01 INFO - Running post-action listener: _resource_record_post_action 14:13:01 INFO - [mozharness: 2017-08-31 21:13:01.908436Z] Finished run-tests step (success) 14:13:01 INFO - Running post-run listener: _resource_record_post_run 14:13:01 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 4096; Write bytes: 394121216; Read time: 4; Write time: 268920 14:13:01 INFO - TinderboxPrint: CPU usage
13.1% 14:13:01 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 4 14:13:01 INFO - TinderboxPrint: I/O write bytes / time
394,121,216 / 268,920 14:13:01 INFO - TinderboxPrint: CPU idle
8,243.3 (86.9%) 14:13:01 INFO - TinderboxPrint: CPU user
1,192.5 (12.6%) 14:13:01 INFO - TinderboxPrint: Swap in / out
0 / 0 14:13:01 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 107180032; Read time: 0; Write time: 82388 14:13:01 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 14:13:02 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 4096; Write bytes: 286941184; Read time: 4; Write time: 186532 14:13:02 INFO - Running post-run listener: _upload_blobber_files 14:13:02 INFO - Blob upload gear active. 14:13:02 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:13:02 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 14:13:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 14:13:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 14:13:02 INFO - (blobuploader) - INFO - Open directory for files ... 14:13:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 14:13:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:13:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:13:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 14:13:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:13:03 INFO - (blobuploader) - INFO - Done attempting. 14:13:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 14:13:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:13:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:13:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 14:13:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:13:04 INFO - (blobuploader) - INFO - Done attempting. 14:13:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 14:13:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:13:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:13:07 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 14:13:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:13:07 INFO - (blobuploader) - INFO - Done attempting. 14:13:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 14:13:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:13:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:13:08 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 14:13:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:13:08 INFO - (blobuploader) - INFO - Done attempting. 14:13:08 INFO - (blobuploader) - INFO - Iteration through files over. 14:13:08 INFO - Return code: 0 14:13:08 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:13:08 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:13:08 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/20260d19b714a07b2331ef002aa7498dba568d7443bd51bb2c3dc170fb542ffb928f0e5ee3e135bb2c7cdc7a0aab8b670a51e4274aee57c1977e08d7fe8769ef", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1b71dbcea2b30b6f0cce703205353bc467dd70089cf08d1304da8da1dbfc3a436fd03dcbdb4a90a98d29aeb6993194aa391f9b79f05e11dd3e9e70858ce07d9d", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/175cc26cd8d9be17a0d46bb4254e709339a803d237ff0c9d1dc01a364d523f531ecc0c32c02419254ce1abbf3e59fb25e6d43b15445f0c6de9e92e7f6af1b455", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2343f811cc3dcf47c48081512175ad7120ea0cc51b570cdaa652058bd47f9e7d63a69c4e0671129f6742c2b96543d94014913f6f93106b31932bea289efc0c43"} 14:13:08 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:13:08 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:13:08 INFO - Contents: 14:13:08 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/20260d19b714a07b2331ef002aa7498dba568d7443bd51bb2c3dc170fb542ffb928f0e5ee3e135bb2c7cdc7a0aab8b670a51e4274aee57c1977e08d7fe8769ef", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1b71dbcea2b30b6f0cce703205353bc467dd70089cf08d1304da8da1dbfc3a436fd03dcbdb4a90a98d29aeb6993194aa391f9b79f05e11dd3e9e70858ce07d9d", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/175cc26cd8d9be17a0d46bb4254e709339a803d237ff0c9d1dc01a364d523f531ecc0c32c02419254ce1abbf3e59fb25e6d43b15445f0c6de9e92e7f6af1b455", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2343f811cc3dcf47c48081512175ad7120ea0cc51b570cdaa652058bd47f9e7d63a69c4e0671129f6742c2b96543d94014913f6f93106b31932bea289efc0c43"} 14:13:08 INFO - Running post-run listener: copy_logs_to_upload_dir 14:13:08 INFO - Copying logs to upload dir... 14:13:08 INFO - mkdir: /builds/slave/test/build/upload/logs 14:13:08 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1251.343726 ========= master_lag: 0.33 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 51 secs) (at 2017-08-31 14:13:09.083271) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-31 14:13:09.089851) ========= 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=41bf3e9aed84707956354da8000001c5-1504212301.368790-1415861466 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/20260d19b714a07b2331ef002aa7498dba568d7443bd51bb2c3dc170fb542ffb928f0e5ee3e135bb2c7cdc7a0aab8b670a51e4274aee57c1977e08d7fe8769ef", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1b71dbcea2b30b6f0cce703205353bc467dd70089cf08d1304da8da1dbfc3a436fd03dcbdb4a90a98d29aeb6993194aa391f9b79f05e11dd3e9e70858ce07d9d", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/175cc26cd8d9be17a0d46bb4254e709339a803d237ff0c9d1dc01a364d523f531ecc0c32c02419254ce1abbf3e59fb25e6d43b15445f0c6de9e92e7f6af1b455", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2343f811cc3dcf47c48081512175ad7120ea0cc51b570cdaa652058bd47f9e7d63a69c4e0671129f6742c2b96543d94014913f6f93106b31932bea289efc0c43"} build_url:https://queue.taskcluster.net/v1/task/ZFWS62EnTCq2ZhmByr1xKg/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011235 build_url: 'https://queue.taskcluster.net/v1/task/ZFWS62EnTCq2ZhmByr1xKg/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/20260d19b714a07b2331ef002aa7498dba568d7443bd51bb2c3dc170fb542ffb928f0e5ee3e135bb2c7cdc7a0aab8b670a51e4274aee57c1977e08d7fe8769ef", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1b71dbcea2b30b6f0cce703205353bc467dd70089cf08d1304da8da1dbfc3a436fd03dcbdb4a90a98d29aeb6993194aa391f9b79f05e11dd3e9e70858ce07d9d", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/175cc26cd8d9be17a0d46bb4254e709339a803d237ff0c9d1dc01a364d523f531ecc0c32c02419254ce1abbf3e59fb25e6d43b15445f0c6de9e92e7f6af1b455", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2343f811cc3dcf47c48081512175ad7120ea0cc51b570cdaa652058bd47f9e7d63a69c4e0671129f6742c2b96543d94014913f6f93106b31932bea289efc0c43"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-31 14:13:09.116244) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-31 14:13:09.116596) ========= 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=41bf3e9aed84707956354da8000001c5-1504212301.368790-1415861466 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004494 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-31 14:13:09.166213) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-31 14:13:09.166528) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-31 14:13:09.166816) ========= ========= Total master_lag: 0.46 =========