builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-072 starttime: 1503166820.92 results: success (0) revision: 10ce8f26a29424dbe21818e816c97a695c97fa07 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-08-19 11:20:20.924624) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-08-19 11:20:20.925049) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-19 11:20:20.925327) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-19 11:20:20.944374) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-19 11:20:20.944652) ========= 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=199fb4c72b90437b990b419b000001c5-1503157798.40273-991027235 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-08-19 11:20:22-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 221M=0s 2017-08-19 11:20:22 (221 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.172672 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-19 11:20:21.135141) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-19 11:20:21.135455) ========= 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=199fb4c72b90437b990b419b000001c5-1503157798.40273-991027235 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018296 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-19 11:20:21.185199) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-19 11:20:21.185496) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 10ce8f26a29424dbe21818e816c97a695c97fa07 --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 10ce8f26a29424dbe21818e816c97a695c97fa07 --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=199fb4c72b90437b990b419b000001c5-1503157798.40273-991027235 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-08-19 11:20:22,450 truncating revision to first 12 chars 2017-08-19 11:20:22,450 Setting DEBUG logging. 2017-08-19 11:20:22,450 attempt 1/10 2017-08-19 11:20:22,450 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/10ce8f26a294?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-08-19 11:20:22,884 unpacking tar archive at: mozilla-central-10ce8f26a294/testing/mozharness/ program finished with exit code 0 elapsedTime=0.762576 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-19 11:20:21.963053) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-19 11:20:21.963392) ========= script_repo_revision: 10ce8f26a29424dbe21818e816c97a695c97fa07 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-19 11:20:21.963813) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-19 11:20:21.964113) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-19 11:20:21.987435) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 51 secs) (at 2017-08-19 11:20:21.987836) ========= /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=199fb4c72b90437b990b419b000001c5-1503157798.40273-991027235 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:20:23 INFO - MultiFileLogger online at 20170819 11:20:23 in /builds/slave/test 11:20:23 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 11:20:23 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:20:23 INFO - {'append_to_log': False, 11:20:23 INFO - 'base_work_dir': '/builds/slave/test', 11:20:23 INFO - 'blob_upload_branch': 'Firefox', 11:20:23 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:20:23 INFO - 'branch': 'Firefox', 11:20:23 INFO - 'buildbot_json_path': 'buildprops.json', 11:20:23 INFO - 'code_coverage': False, 11:20:23 INFO - 'config_files': ('talos/linux_config.py',), 11:20:23 INFO - 'default_actions': ('clobber', 11:20:23 INFO - 'read-buildbot-config', 11:20:23 INFO - 'download-and-extract', 11:20:23 INFO - 'populate-webroot', 11:20:23 INFO - 'create-virtualenv', 11:20:23 INFO - 'install', 11:20:23 INFO - 'setup-mitmproxy', 11:20:23 INFO - 'run-tests'), 11:20:23 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:20:23 INFO - 'disable_ccov_upload': False, 11:20:23 INFO - 'download_minidump_stackwalk': True, 11:20:23 INFO - 'download_symbols': 'ondemand', 11:20:23 INFO - 'enable_stylo': False, 11:20:23 INFO - 'enable_webrender': False, 11:20:23 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:20:23 INFO - 'tooltool.py': '/tools/tooltool.py', 11:20:23 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:20:23 INFO - '/tools/misc-python/virtualenv.py')}, 11:20:23 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:20:23 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:20:23 INFO - 'gecko_profile': False, 11:20:23 INFO - 'gecko_profile_interval': 0, 11:20:23 INFO - 'installer_path': 'installer.exe', 11:20:23 INFO - 'log_level': 'info', 11:20:23 INFO - 'log_name': 'talos', 11:20:23 INFO - 'log_to_console': True, 11:20:23 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:20:23 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:20:23 INFO - 'opt_config_files': (), 11:20:23 INFO - 'pip_index': False, 11:20:23 INFO - 'suite': 'dromaeojs-e10s', 11:20:23 INFO - 'system_bits': '32', 11:20:23 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:20:23 INFO - 'title': 'talos-linux64-ix-072', 11:20:23 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:20:23 INFO - 'use_talos_json': True, 11:20:23 INFO - 'verify': 'False', 11:20:23 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:20:23 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:20:23 INFO - 'work_dir': 'build'} 11:20:23 INFO - [mozharness: 2017-08-19 18:20:23.396487Z] Running clobber step. 11:20:23 INFO - Running pre-action listener: _resource_record_pre_action 11:20:23 INFO - Running main action method: clobber 11:20:23 INFO - rmtree: /builds/slave/test/build 11:20:23 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:20:24 INFO - Running post-action listener: _resource_record_post_action 11:20:24 INFO - [mozharness: 2017-08-19 18:20:24.962355Z] Finished clobber step (success) 11:20:24 INFO - [mozharness: 2017-08-19 18:20:24.962453Z] Running read-buildbot-config step. 11:20:24 INFO - Running pre-action listener: _resource_record_pre_action 11:20:24 INFO - Running main action method: read_buildbot_config 11:20:24 INFO - Using buildbot properties: 11:20:24 INFO - { 11:20:24 INFO - "project": "", 11:20:24 INFO - "product": "firefox", 11:20:24 INFO - "who": "ffxbld@noreply.mozilla.org", 11:20:24 INFO - "installer_path": "public/build/target.tar.bz2", 11:20:24 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 11:20:24 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 11:20:24 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 11:20:24 INFO - "stage_platform": "linux64-pgo", 11:20:24 INFO - "basedir": "/builds/slave/test", 11:20:24 INFO - "buildnumber": 130, 11:20:24 INFO - "platform": "ubuntu64_hw", 11:20:24 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 11:20:24 INFO - "slavebuilddir": "test", 11:20:24 INFO - "taskId": "ag4x5k-WRMKGsUWMbKey0A", 11:20:24 INFO - "branch": "mozilla-central", 11:20:24 INFO - "script_repo_revision": "production", 11:20:24 INFO - "revision": "10ce8f26a29424dbe21818e816c97a695c97fa07", 11:20:24 INFO - "slavename": "talos-linux64-ix-072", 11:20:24 INFO - "repo_path": "mozilla-central" 11:20:24 INFO - } 11:20:24 INFO - Finding installer, test and symbols from parent task. 11:20:24 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ag4x5k-WRMKGsUWMbKey0A'}, attempt #1 11:20:25 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ag4x5k-WRMKGsUWMbKey0A'}, attempt #1 11:20:25 INFO - Task dependencies: b8xBkx50Q2CXfFW1_WrhUg 11:20:25 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/b8xBkx50Q2CXfFW1_WrhUg'}, attempt #1 11:20:26 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/b8xBkx50Q2CXfFW1_WrhUg/artifacts/public/build/target.tar.bz2 11:20:26 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/b8xBkx50Q2CXfFW1_WrhUg/artifacts/public/build/target.test_packages.json 11:20:26 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/b8xBkx50Q2CXfFW1_WrhUg/artifacts/public/build/target.crashreporter-symbols.zip 11:20:26 INFO - Running post-action listener: _resource_record_post_action 11:20:26 INFO - [mozharness: 2017-08-19 18:20:26.450878Z] Finished read-buildbot-config step (success) 11:20:26 INFO - [mozharness: 2017-08-19 18:20:26.451095Z] Running download-and-extract step. 11:20:26 INFO - Running pre-action listener: _resource_record_pre_action 11:20:26 INFO - Running main action method: download_and_extract 11:20:26 INFO - mkdir: /builds/slave/test/build/tests 11:20:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:20:26 INFO - trying https://queue.taskcluster.net/v1/task/b8xBkx50Q2CXfFW1_WrhUg/artifacts/public/build/target.test_packages.json 11:20:26 INFO - Downloading https://queue.taskcluster.net/v1/task/b8xBkx50Q2CXfFW1_WrhUg/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 11:20:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/b8xBkx50Q2CXfFW1_WrhUg/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 11:20:27 INFO - Downloaded 989 bytes. 11:20:27 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 11:20:27 INFO - Using the following test package requirements: 11:20:27 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 11:20:27 INFO - u'common': [u'target.common.tests.zip'], 11:20:27 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 11:20:27 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 11:20:27 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 11:20:27 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 11:20:27 INFO - u'mozbase': [u'target.common.tests.zip'], 11:20:27 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 11:20:27 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 11:20:27 INFO - u'web-platform': [u'target.common.tests.zip', 11:20:27 INFO - u'target.web-platform.tests.tar.gz'], 11:20:27 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 11:20:27 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 11:20:27 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/b8xBkx50Q2CXfFW1_WrhUg/artifacts/public/build/target.common.tests.zip 11:20:27 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/b8xBkx50Q2CXfFW1_WrhUg/artifacts/public/build/target.common.tests.zip'}, attempt #1 11:20:27 INFO - Fetch https://queue.taskcluster.net/v1/task/b8xBkx50Q2CXfFW1_WrhUg/artifacts/public/build/target.common.tests.zip into memory 11:20:28 INFO - Content-Length response header: 54617357 11:20:28 INFO - Bytes received: 54617357 11:20:39 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 11:20:39 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/b8xBkx50Q2CXfFW1_WrhUg/artifacts/public/build/target.common.tests.zip 11:20:39 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/b8xBkx50Q2CXfFW1_WrhUg/artifacts/public/build/target.common.tests.zip'}, attempt #1 11:20:39 INFO - Fetch https://queue.taskcluster.net/v1/task/b8xBkx50Q2CXfFW1_WrhUg/artifacts/public/build/target.common.tests.zip into memory 11:20:41 INFO - Content-Length response header: 54617357 11:20:41 INFO - Bytes received: 54617357 11:20:53 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/b8xBkx50Q2CXfFW1_WrhUg/artifacts/public/build/target.talos.tests.zip 11:20:53 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/b8xBkx50Q2CXfFW1_WrhUg/artifacts/public/build/target.talos.tests.zip'}, attempt #1 11:20:53 INFO - Fetch https://queue.taskcluster.net/v1/task/b8xBkx50Q2CXfFW1_WrhUg/artifacts/public/build/target.talos.tests.zip into memory 11:20:54 INFO - Content-Length response header: 14496256 11:20:54 INFO - Bytes received: 14496256 11:20:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:20:54 INFO - trying https://queue.taskcluster.net/v1/task/b8xBkx50Q2CXfFW1_WrhUg/artifacts/public/build/target.tar.bz2 11:20:54 INFO - Downloading https://queue.taskcluster.net/v1/task/b8xBkx50Q2CXfFW1_WrhUg/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 11:20:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/b8xBkx50Q2CXfFW1_WrhUg/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 11:20:57 INFO - Downloaded 63230779 bytes. 11:20:57 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/b8xBkx50Q2CXfFW1_WrhUg/artifacts/public/build/target.tar.bz2 11:20:57 INFO - mkdir: /builds/slave/test/properties 11:20:57 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:20:57 INFO - Writing to file /builds/slave/test/properties/build_url 11:20:57 INFO - Contents: 11:20:57 INFO - build_url:https://queue.taskcluster.net/v1/task/b8xBkx50Q2CXfFW1_WrhUg/artifacts/public/build/target.tar.bz2 11:20:57 INFO - Running post-action listener: _resource_record_post_action 11:20:57 INFO - Running post-action listener: find_tests_for_verification 11:20:57 INFO - Running post-action listener: set_extra_try_arguments 11:20:57 INFO - [mozharness: 2017-08-19 18:20:57.251488Z] Finished download-and-extract step (success) 11:20:57 INFO - [mozharness: 2017-08-19 18:20:57.251612Z] Running populate-webroot step. 11:20:57 INFO - Running pre-action listener: _resource_record_pre_action 11:20:57 INFO - Running main action method: populate_webroot 11:20:57 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:20:57 INFO - 'chromez-stylo-e10s': {'talos_options': ['--stylo'], 11:20:57 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:20:57 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:20:57 INFO - 'dromaeojs-stylo-e10s': {'talos_options': ['--stylo'], 11:20:57 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:20:57 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 11:20:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:20:57 INFO - 'g1-stylo-e10s': {'pagesets_name': 'tp5n.zip', 11:20:57 INFO - 'talos_options': ['--stylo'], 11:20:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:20:57 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 11:20:57 INFO - 'tests': ['damp', 'tps']}, 11:20:57 INFO - 'g2-stylo-e10s': {'pagesets_name': 'tp5n.zip', 11:20:57 INFO - 'talos_options': ['--stylo'], 11:20:57 INFO - 'tests': ['damp', 'tps']}, 11:20:57 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:20:57 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 11:20:57 INFO - 'g4-stylo-e10s': {'talos_options': ['--stylo'], 11:20:57 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 11:20:57 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 11:20:57 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 11:20:57 INFO - 'g5-stylo-e10s': {'pagesets_name': 'tp5n.zip', 11:20:57 INFO - 'talos_options': ['--stylo'], 11:20:57 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 11:20:57 INFO - 'other-e10s': {'tests': ['a11yr', 11:20:57 INFO - 'ts_paint', 11:20:57 INFO - 'tpaint', 11:20:57 INFO - 'sessionrestore', 11:20:57 INFO - 'sessionrestore_many_windows', 11:20:57 INFO - 'sessionrestore_no_auto_restore', 11:20:57 INFO - 'tabpaint']}, 11:20:57 INFO - 'other-stylo-e10s': {'talos_options': ['--stylo'], 11:20:57 INFO - 'tests': ['a11yr', 11:20:57 INFO - 'ts_paint', 11:20:57 INFO - 'tpaint', 11:20:57 INFO - 'sessionrestore', 11:20:57 INFO - 'sessionrestore_many_windows', 11:20:57 INFO - 'sessionrestore_no_auto_restore', 11:20:57 INFO - 'tabpaint']}, 11:20:57 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 11:20:57 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 11:20:57 INFO - 'perf-reftest-singletons-stylo-e10s': {'talos_options': ['--stylo'], 11:20:57 INFO - 'tests': ['bloom_basic_singleton']}, 11:20:57 INFO - 'perf-reftest-stylo-e10s': {'talos_options': ['--stylo'], 11:20:57 INFO - 'tests': ['bloom_basic']}, 11:20:57 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:20:57 INFO - 'tsvgr_opacity', 11:20:57 INFO - 'tart', 11:20:57 INFO - 'tscrollx', 11:20:57 INFO - 'tsvg_static']}, 11:20:57 INFO - 'svgr-stylo-e10s': {'talos_options': ['--stylo'], 11:20:57 INFO - 'tests': ['tsvgx', 11:20:57 INFO - 'tsvgr_opacity', 11:20:57 INFO - 'tart', 11:20:57 INFO - 'tscrollx', 11:20:57 INFO - 'tsvg_static']}, 11:20:57 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 11:20:57 INFO - 'tp5o-stylo-e10s': {'pagesets_name': 'tp5n.zip', 11:20:57 INFO - 'talos_options': ['--stylo'], 11:20:57 INFO - 'tests': ['tp5o']}, 11:20:57 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:20:57 INFO - 'talos_options': ['--mitmproxy', 11:20:57 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:20:57 INFO - '--firstNonBlankPaint'], 11:20:57 INFO - 'tests': ['tp6_google', 11:20:57 INFO - 'tp6_youtube', 11:20:57 INFO - 'tp6_amazon', 11:20:57 INFO - 'tp6_facebook']}, 11:20:57 INFO - 'tp6-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:20:57 INFO - 'talos_options': ['--stylo', 11:20:57 INFO - '--mitmproxy', 11:20:57 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:20:57 INFO - '--firstNonBlankPaint'], 11:20:57 INFO - 'tests': ['tp6_google', 11:20:57 INFO - 'tp6_youtube', 11:20:57 INFO - 'tp6_amazon', 11:20:57 INFO - 'tp6_facebook']}, 11:20:57 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:20:57 INFO - 'talos_options': ['--stylo', 11:20:57 INFO - '--stylo-threads=1', 11:20:57 INFO - '--mitmproxy', 11:20:57 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:20:57 INFO - '--firstNonBlankPaint'], 11:20:57 INFO - 'tests': ['tp6_google', 11:20:57 INFO - 'tp6_youtube', 11:20:57 INFO - 'tp6_amazon', 11:20:57 INFO - 'tp6_facebook']}, 11:20:57 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 11:20:57 INFO - 'talos_options': ['--xperf_path', 11:20:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:20:57 INFO - 'tests': ['tp5n']}, 11:20:57 INFO - 'xperf-stylo-e10s': {'pagesets_name': 'tp5n.zip', 11:20:57 INFO - 'talos_options': ['--stylo', 11:20:57 INFO - '--xperf_path', 11:20:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:20:57 INFO - 'tests': ['tp5n']}}} 11:20:57 INFO - Running post-action listener: _resource_record_post_action 11:20:57 INFO - [mozharness: 2017-08-19 18:20:57.269143Z] Finished populate-webroot step (success) 11:20:57 INFO - [mozharness: 2017-08-19 18:20:57.269233Z] Running create-virtualenv step. 11:20:57 INFO - Running pre-action listener: _resource_record_pre_action 11:20:57 INFO - Running main action method: create_virtualenv 11:20:57 INFO - Creating virtualenv /builds/slave/test/build/venv 11:20:57 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 11:20:57 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:20:57 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 11:20:57 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:20:57 INFO - Using real prefix '/usr' 11:20:57 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:20:57 INFO - Installing distribute.............................................................................................................................................................................................done. 11:20:59 INFO - Installing pip.................done. 11:20:59 INFO - Return code: 0 11:20:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 11:20:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 11:21:00 INFO - Reading from file tmpfile_stdout 11:21:00 INFO - Output received: 11:21:00 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 11:21:00 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:21:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:21:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:21:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:21:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:21:00 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 0x1e0b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fd6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2179f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2177130>, '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 0x2178030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21784c0>, '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': '199fb4c72b90437b990b419b000001c5-1503157798.40273-991027235', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:21:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 11:21:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 11:21:00 INFO - Using env: {'DISPLAY': ':0', 11:21:00 INFO - 'HOME': '/home/cltbld', 11:21:00 INFO - 'LANG': 'en_US.UTF-8', 11:21:00 INFO - 'LANGUAGE': 'en_US:en', 11:21:00 INFO - 'LOGNAME': 'cltbld', 11:21:00 INFO - 'MAIL': '/var/mail/cltbld', 11:21:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:21:00 INFO - 'MOZ_NO_REMOTE': '1', 11:21:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:21:00 INFO - 'NO_EM_RESTART': '1', 11:21:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:21:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:21:00 INFO - 'PWD': '/builds/slave/test', 11:21:00 INFO - 'SHELL': '/bin/bash', 11:21:00 INFO - 'SHLVL': '1', 11:21:00 INFO - 'TERM': 'linux', 11:21:00 INFO - 'TMOUT': '86400', 11:21:00 INFO - 'USER': 'cltbld', 11:21:00 INFO - 'XDG_SESSION_COOKIE': '199fb4c72b90437b990b419b000001c5-1503157798.40273-991027235', 11:21:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:21:00 INFO - '_': '/tools/buildbot/bin/python'} 11:21:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:21:00 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 11:21:00 INFO - Cleaning up... 11:21:00 INFO - Return code: 0 11:21:00 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:21:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:21:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:21:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:21:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:21:00 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 0x1e0b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fd6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2179f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2177130>, '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 0x2178030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21784c0>, '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': '199fb4c72b90437b990b419b000001c5-1503157798.40273-991027235', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:21:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 11:21:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 11:21:00 INFO - Using env: {'DISPLAY': ':0', 11:21:00 INFO - 'HOME': '/home/cltbld', 11:21:00 INFO - 'LANG': 'en_US.UTF-8', 11:21:00 INFO - 'LANGUAGE': 'en_US:en', 11:21:00 INFO - 'LOGNAME': 'cltbld', 11:21:00 INFO - 'MAIL': '/var/mail/cltbld', 11:21:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:21:00 INFO - 'MOZ_NO_REMOTE': '1', 11:21:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:21:00 INFO - 'NO_EM_RESTART': '1', 11:21:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:21:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:21:00 INFO - 'PWD': '/builds/slave/test', 11:21:00 INFO - 'SHELL': '/bin/bash', 11:21:00 INFO - 'SHLVL': '1', 11:21:00 INFO - 'TERM': 'linux', 11:21:00 INFO - 'TMOUT': '86400', 11:21:00 INFO - 'USER': 'cltbld', 11:21:00 INFO - 'XDG_SESSION_COOKIE': '199fb4c72b90437b990b419b000001c5-1503157798.40273-991027235', 11:21:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:21:00 INFO - '_': '/tools/buildbot/bin/python'} 11:21:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:21:00 INFO - Downloading/unpacking psutil>=3.1.1 11:21:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:21:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:21:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:21:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:21:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:21:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:21:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:21:01 INFO - Installing collected packages: psutil 11:21:01 INFO - Running setup.py install for psutil 11:21:01 INFO - building 'psutil._psutil_linux' extension 11:21:01 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 11:21:01 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 11:21:01 INFO - building 'psutil._psutil_posix' extension 11:21:01 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 11:21:02 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 11:21:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:21:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:21:02 INFO - Successfully installed psutil 11:21:02 INFO - Cleaning up... 11:21:02 INFO - Return code: 0 11:21:02 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:21: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')]} 11:21:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:21: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')]} 11:21:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:21:02 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 0x1e0b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fd6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2179f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2177130>, '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 0x2178030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21784c0>, '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': '199fb4c72b90437b990b419b000001c5-1503157798.40273-991027235', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:21:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 11:21:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 11:21:02 INFO - Using env: {'DISPLAY': ':0', 11:21:02 INFO - 'HOME': '/home/cltbld', 11:21:02 INFO - 'LANG': 'en_US.UTF-8', 11:21:02 INFO - 'LANGUAGE': 'en_US:en', 11:21:02 INFO - 'LOGNAME': 'cltbld', 11:21:02 INFO - 'MAIL': '/var/mail/cltbld', 11:21:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:21:02 INFO - 'MOZ_NO_REMOTE': '1', 11:21:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:21:02 INFO - 'NO_EM_RESTART': '1', 11:21:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:21:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:21:02 INFO - 'PWD': '/builds/slave/test', 11:21:02 INFO - 'SHELL': '/bin/bash', 11:21:02 INFO - 'SHLVL': '1', 11:21:02 INFO - 'TERM': 'linux', 11:21:02 INFO - 'TMOUT': '86400', 11:21:02 INFO - 'USER': 'cltbld', 11:21:02 INFO - 'XDG_SESSION_COOKIE': '199fb4c72b90437b990b419b000001c5-1503157798.40273-991027235', 11:21:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:21:02 INFO - '_': '/tools/buildbot/bin/python'} 11:21:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:21:02 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:21:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:21:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:21:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:21:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:21:03 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:21:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:21:03 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:21:03 INFO - Installing collected packages: mozsystemmonitor 11:21:03 INFO - Running setup.py install for mozsystemmonitor 11:21:03 INFO - Successfully installed mozsystemmonitor 11:21:03 INFO - Cleaning up... 11:21:03 INFO - Return code: 0 11:21:03 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:21:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:21:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:21:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:21:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:21:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1e0b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fd6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2179f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2177130>, '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 0x2178030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21784c0>, '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': '199fb4c72b90437b990b419b000001c5-1503157798.40273-991027235', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:21:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 11:21:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 11:21:03 INFO - Using env: {'DISPLAY': ':0', 11:21:03 INFO - 'HOME': '/home/cltbld', 11:21:03 INFO - 'LANG': 'en_US.UTF-8', 11:21:03 INFO - 'LANGUAGE': 'en_US:en', 11:21:03 INFO - 'LOGNAME': 'cltbld', 11:21:03 INFO - 'MAIL': '/var/mail/cltbld', 11:21:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:21:03 INFO - 'MOZ_NO_REMOTE': '1', 11:21:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:21:03 INFO - 'NO_EM_RESTART': '1', 11:21:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:21:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:21:03 INFO - 'PWD': '/builds/slave/test', 11:21:03 INFO - 'SHELL': '/bin/bash', 11:21:03 INFO - 'SHLVL': '1', 11:21:03 INFO - 'TERM': 'linux', 11:21:03 INFO - 'TMOUT': '86400', 11:21:03 INFO - 'USER': 'cltbld', 11:21:03 INFO - 'XDG_SESSION_COOKIE': '199fb4c72b90437b990b419b000001c5-1503157798.40273-991027235', 11:21:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:21:03 INFO - '_': '/tools/buildbot/bin/python'} 11:21:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:21:04 INFO - Downloading/unpacking jsonschema==2.5.1 11:21:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:21:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:21:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:21:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:21:05 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:21:05 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:21:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:21:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:21:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:21:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:21:05 INFO - Downloading functools32-3.2.3-2.tar.gz 11:21:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:21:05 INFO - warning: no files found matching '*.txt' 11:21:05 INFO - no previously-included directories found matching 'build' 11:21:05 INFO - no previously-included directories found matching 'dist' 11:21:05 INFO - no previously-included directories found matching '.git*' 11:21:05 INFO - Installing collected packages: jsonschema, functools32 11:21:05 INFO - Running setup.py install for functools32 11:21:05 INFO - warning: no files found matching '*.txt' 11:21:05 INFO - no previously-included directories found matching 'build' 11:21:05 INFO - no previously-included directories found matching 'dist' 11:21:05 INFO - no previously-included directories found matching '.git*' 11:21:05 INFO - Successfully installed jsonschema functools32 11:21:05 INFO - Cleaning up... 11:21:05 INFO - Return code: 0 11:21:05 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 11:21: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')]} 11:21:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:21: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')]} 11:21:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:21:05 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 0x1e0b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fd6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2179f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2177130>, '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 0x2178030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21784c0>, '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': '199fb4c72b90437b990b419b000001c5-1503157798.40273-991027235', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:21:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 11:21:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 11:21:05 INFO - Using env: {'DISPLAY': ':0', 11:21:05 INFO - 'HOME': '/home/cltbld', 11:21:05 INFO - 'LANG': 'en_US.UTF-8', 11:21:05 INFO - 'LANGUAGE': 'en_US:en', 11:21:05 INFO - 'LOGNAME': 'cltbld', 11:21:05 INFO - 'MAIL': '/var/mail/cltbld', 11:21:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:21:05 INFO - 'MOZ_NO_REMOTE': '1', 11:21:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:21:05 INFO - 'NO_EM_RESTART': '1', 11:21:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:21:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:21:05 INFO - 'PWD': '/builds/slave/test', 11:21:05 INFO - 'SHELL': '/bin/bash', 11:21:05 INFO - 'SHLVL': '1', 11:21:05 INFO - 'TERM': 'linux', 11:21:05 INFO - 'TMOUT': '86400', 11:21:05 INFO - 'USER': 'cltbld', 11:21:05 INFO - 'XDG_SESSION_COOKIE': '199fb4c72b90437b990b419b000001c5-1503157798.40273-991027235', 11:21:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:21:05 INFO - '_': '/tools/buildbot/bin/python'} 11:21:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:21:05 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 11:21:05 INFO - Cleaning up... 11:21:05 INFO - Return code: 0 11:21:05 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:21: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')]} 11:21:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:21: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')]} 11:21:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:21:05 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 0x1e0b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fd6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2179f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2177130>, '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 0x2178030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21784c0>, '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': '199fb4c72b90437b990b419b000001c5-1503157798.40273-991027235', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:21:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 11:21:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 11:21:05 INFO - Using env: {'DISPLAY': ':0', 11:21:05 INFO - 'HOME': '/home/cltbld', 11:21:05 INFO - 'LANG': 'en_US.UTF-8', 11:21:05 INFO - 'LANGUAGE': 'en_US:en', 11:21:05 INFO - 'LOGNAME': 'cltbld', 11:21:05 INFO - 'MAIL': '/var/mail/cltbld', 11:21:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:21:05 INFO - 'MOZ_NO_REMOTE': '1', 11:21:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:21:05 INFO - 'NO_EM_RESTART': '1', 11:21:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:21:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:21:05 INFO - 'PWD': '/builds/slave/test', 11:21:05 INFO - 'SHELL': '/bin/bash', 11:21:05 INFO - 'SHLVL': '1', 11:21:05 INFO - 'TERM': 'linux', 11:21:05 INFO - 'TMOUT': '86400', 11:21:05 INFO - 'USER': 'cltbld', 11:21:05 INFO - 'XDG_SESSION_COOKIE': '199fb4c72b90437b990b419b000001c5-1503157798.40273-991027235', 11:21:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:21:05 INFO - '_': '/tools/buildbot/bin/python'} 11:21:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:21:06 INFO - Downloading/unpacking blobuploader==1.2.4 11:21: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 11:21: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 11:21: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 11:21: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 11:21:07 INFO - Downloading blobuploader-1.2.4.tar.gz 11:21:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:21:07 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:21:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:21:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:21:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:21:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:21:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:21:07 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:21:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:21:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:21:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:21:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:21:07 INFO - Downloading docopt-0.6.1.tar.gz 11:21:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:21:07 INFO - Installing collected packages: blobuploader, requests, docopt 11:21:07 INFO - Running setup.py install for blobuploader 11:21:07 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:21:07 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:21:07 INFO - Running setup.py install for requests 11:21:08 INFO - Running setup.py install for docopt 11:21:08 INFO - Successfully installed blobuploader requests docopt 11:21:08 INFO - Cleaning up... 11:21:08 INFO - Return code: 0 11:21:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:21: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')]} 11:21:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:21: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')]} 11:21:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:21:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e0b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fd6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2179f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2177130>, '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 0x2178030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21784c0>, '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': '199fb4c72b90437b990b419b000001c5-1503157798.40273-991027235', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:21:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 11:21:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:21:08 INFO - Using env: {'DISPLAY': ':0', 11:21:08 INFO - 'HOME': '/home/cltbld', 11:21:08 INFO - 'LANG': 'en_US.UTF-8', 11:21:08 INFO - 'LANGUAGE': 'en_US:en', 11:21:08 INFO - 'LOGNAME': 'cltbld', 11:21:08 INFO - 'MAIL': '/var/mail/cltbld', 11:21:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:21:08 INFO - 'MOZ_NO_REMOTE': '1', 11:21:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:21:08 INFO - 'NO_EM_RESTART': '1', 11:21:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:21:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:21:08 INFO - 'PWD': '/builds/slave/test', 11:21:08 INFO - 'SHELL': '/bin/bash', 11:21:08 INFO - 'SHLVL': '1', 11:21:08 INFO - 'TERM': 'linux', 11:21:08 INFO - 'TMOUT': '86400', 11:21:08 INFO - 'USER': 'cltbld', 11:21:08 INFO - 'XDG_SESSION_COOKIE': '199fb4c72b90437b990b419b000001c5-1503157798.40273-991027235', 11:21:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:21:08 INFO - '_': '/tools/buildbot/bin/python'} 11:21:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:21:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:21:08 INFO - Running setup.py (path:/tmp/pip-Z4KVsM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:21:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:21:08 INFO - Running setup.py (path:/tmp/pip-qodk43-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:21:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:21:08 INFO - Running setup.py (path:/tmp/pip-OiXxjH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:21:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:21:08 INFO - Running setup.py (path:/tmp/pip-L9FY3F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:21:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:21:08 INFO - Running setup.py (path:/tmp/pip-jlcBHr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:21:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:21:08 INFO - Running setup.py (path:/tmp/pip-yNg4mO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:21:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:21:08 INFO - Running setup.py (path:/tmp/pip-9wqfX6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:21:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:21:09 INFO - Running setup.py (path:/tmp/pip-kTV1sY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:21:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:21:09 INFO - Running setup.py (path:/tmp/pip-Vt99yF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:21:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:21:09 INFO - Running setup.py (path:/tmp/pip-w1j3Jh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:21:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:21:09 INFO - Running setup.py (path:/tmp/pip-uolWtk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:21:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:21:09 INFO - Running setup.py (path:/tmp/pip-aNufsT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:21:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:21:09 INFO - Running setup.py (path:/tmp/pip-apIemx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:21:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:21:09 INFO - Running setup.py (path:/tmp/pip-H9N8fR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:21:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:21:09 INFO - Running setup.py (path:/tmp/pip-ceBccI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:21:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:21:09 INFO - Running setup.py (path:/tmp/pip-RHzMhd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:21:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:21:09 INFO - Running setup.py (path:/tmp/pip-jML0_Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:21:09 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:21:09 INFO - Running setup.py install for manifestparser 11:21:09 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:21:09 INFO - Running setup.py install for mozcrash 11:21:09 INFO - Running setup.py install for mozdebug 11:21:10 INFO - Running setup.py install for mozdevice 11:21:10 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:21:10 INFO - Running setup.py install for mozfile 11:21:10 INFO - Running setup.py install for mozhttpd 11:21:10 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:21:10 INFO - Running setup.py install for mozinfo 11:21:10 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:21:10 INFO - Running setup.py install for mozInstall 11:21:10 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:21:10 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:21:10 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:21:10 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:21:10 INFO - Running setup.py install for mozleak 11:21:10 INFO - Running setup.py install for mozlog 11:21:10 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:21:10 INFO - Running setup.py install for moznetwork 11:21:10 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:21:10 INFO - Running setup.py install for mozprocess 11:21:10 INFO - Running setup.py install for mozprofile 11:21:11 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:21:11 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:21:11 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:21:11 INFO - Running setup.py install for mozrunner 11:21:11 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:21:11 INFO - Running setup.py install for mozscreenshot 11:21:11 INFO - Running setup.py install for moztest 11:21:11 INFO - Running setup.py install for mozversion 11:21:11 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:21:11 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:21:11 INFO - Cleaning up... 11:21:11 INFO - Return code: 0 11:21:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:21: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')]} 11:21:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:21: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')]} 11:21:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:21:11 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 0x1e0b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fd6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2179f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2177130>, '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 0x2178030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21784c0>, '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': '199fb4c72b90437b990b419b000001c5-1503157798.40273-991027235', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:21:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 11:21:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:21:11 INFO - Using env: {'DISPLAY': ':0', 11:21:11 INFO - 'HOME': '/home/cltbld', 11:21:11 INFO - 'LANG': 'en_US.UTF-8', 11:21:11 INFO - 'LANGUAGE': 'en_US:en', 11:21:11 INFO - 'LOGNAME': 'cltbld', 11:21:11 INFO - 'MAIL': '/var/mail/cltbld', 11:21:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:21:11 INFO - 'MOZ_NO_REMOTE': '1', 11:21:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:21:11 INFO - 'NO_EM_RESTART': '1', 11:21:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:21:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:21:11 INFO - 'PWD': '/builds/slave/test', 11:21:11 INFO - 'SHELL': '/bin/bash', 11:21:11 INFO - 'SHLVL': '1', 11:21:11 INFO - 'TERM': 'linux', 11:21:11 INFO - 'TMOUT': '86400', 11:21:11 INFO - 'USER': 'cltbld', 11:21:11 INFO - 'XDG_SESSION_COOKIE': '199fb4c72b90437b990b419b000001c5-1503157798.40273-991027235', 11:21:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:21:11 INFO - '_': '/tools/buildbot/bin/python'} 11:21:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:21:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:21:11 INFO - Running setup.py (path:/tmp/pip-RqWxav-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:21:11 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 11:21:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:21:11 INFO - Running setup.py (path:/tmp/pip-A9WXgU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:21:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:21:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:21:11 INFO - Running setup.py (path:/tmp/pip-ZrSe_g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:21:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 11:21:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:21:11 INFO - Running setup.py (path:/tmp/pip-ftAStE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:21:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.51 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:21:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:21:12 INFO - Running setup.py (path:/tmp/pip-lvHHut-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:21:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 11:21:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:21:12 INFO - Running setup.py (path:/tmp/pip-ipLNbh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:21:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 11:21:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:21:12 INFO - Running setup.py (path:/tmp/pip-RGCsvI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:21:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.10 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 11:21:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:21:12 INFO - Running setup.py (path:/tmp/pip-p5zbsh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:21:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.13 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 11:21:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:21:12 INFO - Running setup.py (path:/tmp/pip-QOGOWh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:21:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 11:21:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:21:12 INFO - Running setup.py (path:/tmp/pip-gZAprx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:21:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.5 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:21:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:21:12 INFO - Running setup.py (path:/tmp/pip-cbmiYc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:21:12 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 11:21:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:21:12 INFO - Running setup.py (path:/tmp/pip-gjleJ9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:21:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 11:21:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:21:12 INFO - Running setup.py (path:/tmp/pip-PnjAFu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:21:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 11:21:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:21:12 INFO - Running setup.py (path:/tmp/pip-wcnDBG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:21:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 11:21:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:21:12 INFO - Running setup.py (path:/tmp/pip-SGDIu9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:21:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 11:21:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:21:12 INFO - Running setup.py (path:/tmp/pip-F5O18Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:21:12 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 11:21:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:21:12 INFO - Running setup.py (path:/tmp/pip-L76V2Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:21:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 11:21:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:21:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:21:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 11:21:12 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:21:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:21:12 INFO - Requirement already satisfied (use --upgrade to upgrade): requests in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozInstall==1.13->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 11:21:12 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:21:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:21:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:21:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:21:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:21:14 INFO - Downloading blessings-1.6.tar.gz 11:21:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:21:14 INFO - Installing collected packages: blessings 11:21:14 INFO - Running setup.py install for blessings 11:21:14 INFO - Successfully installed blessings 11:21:14 INFO - Cleaning up... 11:21:14 INFO - Return code: 0 11:21:14 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:21:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:21:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:21:14 INFO - Reading from file tmpfile_stdout 11:21:14 INFO - Current package versions: 11:21:14 INFO - argparse == 1.2.1 11:21:14 INFO - blessings == 1.6 11:21:14 INFO - blobuploader == 1.2.4 11:21:14 INFO - docopt == 0.6.1 11:21:14 INFO - functools32 == 3.2.3-2 11:21:14 INFO - jsonschema == 2.5.1 11:21:14 INFO - manifestparser == 1.1 11:21:14 INFO - mozInstall == 1.13 11:21:14 INFO - mozcrash == 1.0 11:21:14 INFO - mozdebug == 0.1 11:21:14 INFO - mozdevice == 0.51 11:21:14 INFO - mozfile == 1.2 11:21:14 INFO - mozhttpd == 0.7 11:21:14 INFO - mozinfo == 0.10 11:21:14 INFO - mozleak == 0.1 11:21:14 INFO - mozlog == 3.5 11:21:14 INFO - moznetwork == 0.27 11:21:14 INFO - mozprocess == 0.25 11:21:14 INFO - mozprofile == 0.28 11:21:14 INFO - mozrunner == 6.13 11:21:14 INFO - mozscreenshot == 0.1 11:21:14 INFO - mozsystemmonitor == 0.3 11:21:14 INFO - moztest == 0.8 11:21:14 INFO - mozversion == 1.4 11:21:14 INFO - psutil == 3.1.1 11:21:14 INFO - requests == 1.2.3 11:21:14 INFO - wsgiref == 0.1.2 11:21:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:21:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:21:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:21:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:21:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:21:14 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 0x1e0b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fd6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2179f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2177130>, '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 0x2178030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21784c0>, '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': '199fb4c72b90437b990b419b000001c5-1503157798.40273-991027235', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:21:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 11:21:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:21:14 INFO - Using env: {'DISPLAY': ':0', 11:21:14 INFO - 'HOME': '/home/cltbld', 11:21:14 INFO - 'LANG': 'en_US.UTF-8', 11:21:14 INFO - 'LANGUAGE': 'en_US:en', 11:21:14 INFO - 'LOGNAME': 'cltbld', 11:21:14 INFO - 'MAIL': '/var/mail/cltbld', 11:21:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:21:14 INFO - 'MOZ_NO_REMOTE': '1', 11:21:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:21:14 INFO - 'NO_EM_RESTART': '1', 11:21:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:21:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:21:14 INFO - 'PWD': '/builds/slave/test', 11:21:14 INFO - 'SHELL': '/bin/bash', 11:21:14 INFO - 'SHLVL': '1', 11:21:14 INFO - 'TERM': 'linux', 11:21:14 INFO - 'TMOUT': '86400', 11:21:14 INFO - 'USER': 'cltbld', 11:21:14 INFO - 'XDG_SESSION_COOKIE': '199fb4c72b90437b990b419b000001c5-1503157798.40273-991027235', 11:21:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:21:14 INFO - '_': '/tools/buildbot/bin/python'} 11:21:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:21:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 11:21:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 11:21:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 11:21:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 11:21:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 11:21:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 11:21:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 11:21:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 11:21:14 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 11:21:14 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 11:21:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:21:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:21:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:21:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:21:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 11:21:15 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 11:21:15 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 11:21:15 INFO - Installing collected packages: simplejson 11:21:15 INFO - Running setup.py install for simplejson 11:21:16 INFO - building 'simplejson._speedups' extension 11:21:16 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c simplejson/_speedups.c -o build/temp.linux-x86_64-2.7/simplejson/_speedups.o 11:21:16 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/simplejson/_speedups.o -o build/lib.linux-x86_64-2.7/simplejson/_speedups.so 11:21:16 INFO - Successfully installed simplejson 11:21:16 INFO - Cleaning up... 11:21:16 INFO - Return code: 0 11:21:16 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:21:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:21:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:21:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:21:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:21:16 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 0x1e0b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fd6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2179f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2177130>, '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 0x2178030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21784c0>, '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': '199fb4c72b90437b990b419b000001c5-1503157798.40273-991027235', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:21:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 11:21:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 11:21:16 INFO - Using env: {'DISPLAY': ':0', 11:21:16 INFO - 'HOME': '/home/cltbld', 11:21:16 INFO - 'LANG': 'en_US.UTF-8', 11:21:16 INFO - 'LANGUAGE': 'en_US:en', 11:21:16 INFO - 'LOGNAME': 'cltbld', 11:21:16 INFO - 'MAIL': '/var/mail/cltbld', 11:21:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:21:16 INFO - 'MOZ_NO_REMOTE': '1', 11:21:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:21:16 INFO - 'NO_EM_RESTART': '1', 11:21:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:21:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:21:16 INFO - 'PWD': '/builds/slave/test', 11:21:16 INFO - 'SHELL': '/bin/bash', 11:21:16 INFO - 'SHLVL': '1', 11:21:16 INFO - 'TERM': 'linux', 11:21:16 INFO - 'TMOUT': '86400', 11:21:16 INFO - 'USER': 'cltbld', 11:21:16 INFO - 'XDG_SESSION_COOKIE': '199fb4c72b90437b990b419b000001c5-1503157798.40273-991027235', 11:21:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:21:16 INFO - '_': '/tools/buildbot/bin/python'} 11:21:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:21:17 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:21:17 INFO - Cleaning up... 11:21:17 INFO - Return code: 0 11:21:17 INFO - Running post-action listener: _resource_record_post_action 11:21:17 INFO - Running post-action listener: _start_resource_monitoring 11:21:17 INFO - Starting resource monitoring. 11:21:17 INFO - [mozharness: 2017-08-19 18:21:17.227958Z] Finished create-virtualenv step (success) 11:21:17 INFO - [mozharness: 2017-08-19 18:21:17.228471Z] Running install step. 11:21:17 INFO - Running pre-action listener: _resource_record_pre_action 11:21:17 INFO - Running main action method: install 11:21:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:21:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:21:17 INFO - Reading from file tmpfile_stdout 11:21:17 INFO - Detecting whether we're running mozinstall >=1.0... 11:21:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:21:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:21:17 INFO - Reading from file tmpfile_stdout 11:21:17 INFO - Output received: 11:21:17 INFO - Usage: mozinstall [options] installer 11:21:17 INFO - Options: 11:21:17 INFO - -h, --help show this help message and exit 11:21:17 INFO - -d DEST, --destination=DEST 11:21:17 INFO - Directory to install application into. [default: 11:21:17 INFO - "/builds/slave/test"] 11:21:17 INFO - --app=APP Application being installed. [default: firefox] 11:21:17 INFO - mkdir: /builds/slave/test/build/application 11:21:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 11:21:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 11:21:35 INFO - Reading from file tmpfile_stdout 11:21:35 INFO - Output received: 11:21:35 INFO - /builds/slave/test/build/application/firefox/firefox 11:21:35 INFO - Running post-action listener: _resource_record_post_action 11:21:35 INFO - [mozharness: 2017-08-19 18:21:35.468191Z] Finished install step (success) 11:21:35 INFO - [mozharness: 2017-08-19 18:21:35.468472Z] Running setup-mitmproxy step. 11:21:35 INFO - Running pre-action listener: _resource_record_pre_action 11:21:35 INFO - Running main action method: setup_mitmproxy 11:21:35 INFO - Skipping: mitmproxy is not required 11:21:35 INFO - Running post-action listener: _resource_record_post_action 11:21:35 INFO - [mozharness: 2017-08-19 18:21:35.469698Z] Finished setup-mitmproxy step (success) 11:21:35 INFO - [mozharness: 2017-08-19 18:21:35.469917Z] Running run-tests step. 11:21:35 INFO - Running pre-action listener: _resource_record_pre_action 11:21:35 INFO - Running pre-action listener: _set_gcov_prefix 11:21:35 INFO - Running main action method: run_tests 11:21:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:21:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:21:35 INFO - Python 2.7.3 11:21:35 INFO - Return code: 0 11:21:35 INFO - grabbing minidump binary from tooltool 11:21:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:21:35 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2177130>, '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 0x2178030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21784c0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:21:35 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 11:21:35 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 11:21:35 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 11:21:35 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:21:35 INFO - Return code: 0 11:21:35 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:21:35 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:21:35 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:21:35 INFO - ENV: RUST_BACKTRACE is now full 11:21:35 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:21:35 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:21:35 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/b8xBkx50Q2CXfFW1_WrhUg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-072', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 11:21:35 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/b8xBkx50Q2CXfFW1_WrhUg/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-072 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 11:21:35 INFO - Using env: {'DISPLAY': ':0', 11:21:35 INFO - 'HOME': '/home/cltbld', 11:21:35 INFO - 'LANG': 'en_US.UTF-8', 11:21:35 INFO - 'LANGUAGE': 'en_US:en', 11:21:35 INFO - 'LOGNAME': 'cltbld', 11:21:35 INFO - 'MAIL': '/var/mail/cltbld', 11:21:35 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:21:35 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:21:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:21:35 INFO - 'MOZ_NO_REMOTE': '1', 11:21:35 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:21:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:21:35 INFO - 'NO_EM_RESTART': '1', 11:21:35 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:21:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:21:35 INFO - 'PWD': '/builds/slave/test', 11:21:35 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:21:35 INFO - 'RUST_BACKTRACE': 'full', 11:21:35 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 11:21:35 INFO - 'SHELL': '/bin/bash', 11:21:35 INFO - 'SHLVL': '1', 11:21:35 INFO - 'TERM': 'linux', 11:21:35 INFO - 'TMOUT': '86400', 11:21:35 INFO - 'USER': 'cltbld', 11:21:35 INFO - 'XDG_SESSION_COOKIE': '199fb4c72b90437b990b419b000001c5-1503157798.40273-991027235', 11:21:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:21:35 INFO - '_': '/tools/buildbot/bin/python'} 11:21:35 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/b8xBkx50Q2CXfFW1_WrhUg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-072', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 11:21:35 INFO - mozversion application_buildid: 20170819171054 11:21:35 INFO - mozversion application_changeset: 10ce8f26a29424dbe21818e816c97a695c97fa07 11:21:35 INFO - mozversion application_display_name: Nightly 11:21:35 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:21:35 INFO - mozversion application_name: Firefox 11:21:35 INFO - mozversion application_remotingname: firefox 11:21:35 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 11:21:35 INFO - mozversion application_vendor: Mozilla 11:21:35 INFO - mozversion application_version: 57.0a1 11:21:35 INFO - mozversion platform_buildid: 20170819171054 11:21:35 INFO - mozversion platform_changeset: 10ce8f26a29424dbe21818e816c97a695c97fa07 11:21:35 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 11:21:35 INFO - mozversion platform_version: 57.0a1 11:21:35 INFO - using testdate: 1503166895 11:21:35 INFO - actual date: 1503166895 11:21:35 INFO - starting webserver on 'localhost:39932' 11:21:35 INFO - SUITE-START | Running 2 tests 11:21:35 INFO - TEST-START | dromaeo_css 11:21:35 INFO - Initialising browser for dromaeo_css test... 11:21:35 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:39932/getInfo.html -profile /tmp/tmp2Y_l1D/profile 11:21:35 INFO - TEST-INFO | started process 18222 (/builds/slave/test/build/application/firefox/firefox http://localhost:39932/getInfo.html) 11:21:41 INFO - TEST-INFO | 18222: exit 0 11:21:41 INFO - Browser initialized. 11:21:41 INFO - Running cycle 1/1 for dromaeo_css test... 11:21:41 INFO - TEST-INFO | started process 18438 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp2Y_l1D/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 11:21:42 INFO - PID 18438 | 11:21:42 INFO - PID 18438 | (/builds/slave/test/build/application/firefox/firefox:18490): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 11:21:42 INFO - PID 18438 | 11:21:43 INFO - PID 18438 | 11:21:43 INFO - PID 18438 | (/builds/slave/test/build/application/firefox/firefox:18549): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 11:21:43 INFO - PID 18438 | 11:21:43 INFO - PID 18438 | __metrics Screen width/height:1600/1200 11:21:43 INFO - PID 18438 | colorDepth:24 11:21:43 INFO - PID 18438 | Browser inner width/height: 1024/768 11:21:43 INFO - PID 18438 | __metrics 11:21:52 INFO - PID 18438 | RSS: Main: 164712448 11:21:52 INFO - PID 18438 | 11:24:50 INFO - PID 18438 | Cycle 1(1): loaded http://localhost:39932/tests/dromaeo/cssquery-dojo.html (next: http://localhost:39932/tests/dromaeo/cssquery-ext.html) 11:24:51 INFO - PID 18438 | RSS: Main: 169873408 11:24:51 INFO - PID 18438 | 11:27:53 INFO - PID 18438 | Cycle 1(1): loaded http://localhost:39932/tests/dromaeo/cssquery-ext.html (next: http://localhost:39932/tests/dromaeo/cssquery-jquery.html) 11:27:53 INFO - PID 18438 | RSS: Main: 166162432 11:27:53 INFO - PID 18438 | 11:30:55 INFO - PID 18438 | Cycle 1(1): loaded http://localhost:39932/tests/dromaeo/cssquery-jquery.html (next: http://localhost:39932/tests/dromaeo/cssquery-mootools.html) 11:30:55 INFO - PID 18438 | RSS: Main: 168583168 11:30:55 INFO - PID 18438 | 11:33:57 INFO - PID 18438 | Cycle 1(1): loaded http://localhost:39932/tests/dromaeo/cssquery-mootools.html (next: http://localhost:39932/tests/dromaeo/cssquery-prototype.html) 11:33:58 INFO - PID 18438 | RSS: Main: 166821888 11:33:58 INFO - PID 18438 | 11:37:01 INFO - PID 18438 | Cycle 1(1): loaded http://localhost:39932/tests/dromaeo/cssquery-prototype.html (next: http://localhost:39932/tests/dromaeo/cssquery-yui.html) 11:37:01 INFO - PID 18438 | RSS: Main: 168411136 11:37:01 INFO - PID 18438 | 11:40:03 INFO - PID 18438 | Cycle 1(1): loaded http://localhost:39932/tests/dromaeo/cssquery-yui.html (next: http://localhost:39932/tests/dromaeo/cssquery-dojo.html) 11:40:03 INFO - PID 18438 | RSS: Main: 170524672 11:40:03 INFO - PID 18438 | 11:40:03 INFO - PID 18438 | __start_tp_report 11:40:03 INFO - PID 18438 | _x_x_mozilla_page_load 11:40:03 INFO - PID 18438 | _x_x_mozilla_page_load_details 11:40:03 INFO - PID 18438 | |i|pagename|runs| 11:40:03 INFO - PID 18438 | |0;dojo.html;3424.8458819353127;3502.299540091982;3505.0711561436215;3508.6842184203424;3529.9117522061947;6169.784057557987;6253.499720022399;6286.528510361718;6303.054541818729;6323.5889667171605;6135.29444113927;6154.784582539612;6174.197354343929;6245.219347581552;6261.780837670683;5422.728863556807;5434.429384914567;5444.945550544503;5487.835364939058;5590.105583106703;5568.55451563876;5595.300587426572;5602.523785478239;5615.157726341041;5632.183333416652;5451.3458384994055;5506.449355064502;5518.724063796794;5601.719914004304;5605.691686957216;5334.759935802898;5421.376541697716;5467.152591348347;5469.316335458067;5545.473180047889;5440.809571665012;5462.890742185174;5499.450054994509;5522.5581953443625;5527.806526771544;6047.5766696331275;6118.418750218722;6138.14066030756;6155.322914479404;6188.504919606421;6676.298988606175;6708.932910670879;6712.127423434971;6741.494387920926;6749.7300107995625;6829.931700683029;6838.829029274259;6841.965790171017;6845.178578570553;6848.212455567574;6299.716512756937;6308.463780578656;6373.617582944992;6382.904256436157;6396.904046439307;6999.440044796404;7008.509404341749;7010.859782804316;7090.078289822393;7106.751263705745;6511.9348806511325;6677.599344039373;6709.329067093252;6750.966245168841;6758.256591774901;6654.168228971379;6723.226828914738;6882.621455819878;6884.621345825927;6888.931110688929;6768.526203165829;6770.661466926634;6834.2482326944;6845.623490707959;6857.27998560154;6800.183977922582;6807.5575087619145;6877.243503214642;6881.41507971818;6881.621510816853;4799.856004319876;4814.253790662453;4876.146674331978;4895.755212239374;4906.165951788204;4329.350597410351;4342.717723348035;4354.346847972829;4363.323684828857;4368.27923392643;6401.295857455676;6406.743730250738;6485.319041500669;6489.448396886223;6492.902606460907;6715.832104197434;6789.966050169816;6875.759348422881;6901.930980690129;6920.653967301615;6407.103005579223;6413.903791443132;6466.482681385478;6483.3192514786215;6484.902726459107;5400.540954018952;5444.346678398539;5505.311836020497;5515.393306736256;5541.833744987657;6952.687129079203;7033;7069.08101946754;7163.06880105583;7170.569765814068;6738.258791533026;6773.017912402773;6804.795856124225;6846.486513511407;6848.486363522656;6975.267596902455;6988.825279368057;7016.579005259497;7097.787066388017;7108.9289107110335;6390.808275751735;6507.316731743288;6571.408573228432;6665.433438157617;6688.7324507019175;6799.252082271045;6819.863602728017;6822.317768223138;6857.142857142857;6888.070110535214;6443.871122577429;6535.803925882231;6586.110875032001;6605.603663780189;6672.232693240146;6467.029945508211;6586.341365863375;6592;6669.0329902164885;6673.933260667525;6527.967360163168;6596.274409815012;6597.0764093026055;6611.66941652925;6668.333166683293;6641.50188735837;6642.4686025118845;6681.365270299314;6731.663416829237;6742.08981787472;6406.295307516262;6412.23053233615;6428.807135785747;6511.218653761579;6560.967195163994 11:40:03 INFO - PID 18438 | |1;ext.html;881.5825481840571;904.0733248420369;926.4996901673097;956.5504213019879;958.5399008475931;41417.92910354482;42091.57908420915;42196.789016054914;42292.57707422925;42333;39214.8039259804;39216.607833921655;39419.60580394195;39572.60427395725;39594.80202598983;6901.6204108774;7014.719411223545;7015.543989640657;7016.929830701679;7017.473689473284;6877.793666190022;6958.930410695879;6977.406920411746;6979.511434199608;6985.371316581507;6916.688749006282;6921.204061532938;6929.826754331131;6936.063631409771;6939.23668396476;6889.414399776025;6894.448444124458;6920.619365934872;6927.203371612279;6928.203256625477;6337.524685648548;6375.617462952191;6394.168758061469;6396.840078998016;6398;34231.315373692385;34520;34523.654763452294;34524.65475345239;34540.309193815985;3329;3348.464245720673;3368.6631336866362;3368.7473439492137;3369.528266042756;27297.45405091907;27389.45221095567;27393.726062739515;27551.724482755315;27569.862150689318;4496.730196188207;4563.452385713703;4577.954220457819;4603.723776573416;4605.0559635274685;201715;203187;203497;205597;214352;51378.22932656013;51393.743031285354;51434;51576.742116289926;51683;54318.18522722162;54452.727736361856;54654.45345546573;54700.45299547033;54794.726026369615;15718.842811571738;15794.763078553831;15830.44593439224;15854.603634908988;15941.681166376608;13060.934695326652;13064.869351306364;13069.281189534668;13071.281079540526;13071.41178646963;13709.794353084711;13775.104618199784;13843.515476958259;13878.653033674036;13926.164430134224;5560.972195138998;5584.413636568183;5650.5479561634975;5696.174054762037;5699.088145896637;1075.4622688655672;1078.4931082391263;1082.6697857153645;1096.6709987003867;1101.372217835826;24214.63678044831;24577.631335529983;24609.63085553718;24633;24651.753482465305;1175.506287359311;1197.6167426820564;1208.9214201076902;1210.4613447015993;1212.2241765270235;12687.619371418872;12783.744325113446;13014.15407998477;13051.28217948003;13103.27931963732;254296;254435;254675;254752;255789;53778.193327100125;53989;54106.729466352415;54170.45829541733;54221.72889135529;1496.6931778985281;1506.5254444849836;1515.5226103777275;1516.196415899575;1551.95344139676;24250.87874560616;29070.56394154047;29357.7064229355;30021;30678;52480;52505.47494525006;52520.47479525156;52703.73648131735;52824.47175528196;220580;221297;221393;222175;222678;34284.65715342815;34795.65204348025;36646.26707465889;37061.258774823815;37066.8146659265;47026.29460558026;47484.52515474939;47531;47632;48133.278000830716;34776;34982;35041.649583504855;35360.82319588386;35769;34507.13732156716;34901.82549087238;34940.47589286112;35156.29687406187;35743.46384804178;39505.604943950195;40261.59738402579;40410.1917961645;40411.595884040784;40417.39373909453;33365.33269334551;33792.241551690255;33951.66048339485;34002.31995360128;34197.829010855785;25596.616050759625;25690.871545642152;25842.612360814226;25916.219932641474;26306.73693263043 11:40:03 INFO - PID 18438 | |2;jquery.html;570.6975303089363;574.4772257245907;576.5358886096693;578.1587789765891;586.3637952821189;22053.558928821414;22739.658905116437;23319.300420987398;23452.179173728902;23459.178928737478;27132.864335678343;27488.99999999995;27659.446811063768;27667.723322766768;27696.584551231746;6295.370462953702;6426.710798014101;6433.099366088752;6434.517411194156;6446.709898054575;5751.856203594902;6202.937970620281;6249.3438188990185;6253.53098517613;6429.967850160766;6206.255249370082;6214.067889816519;6220.098085777559;6229.439350458458;6230.532710046742;6216.067589861512;6223.159873417076;6229.065640153991;6234.470070044052;6235.812925612239;5771.797987070432;5798.594098413113;5801.7099145042575;5801.767929282823;5809.448102430262;29938.85030574855;30789.846050769604;30827.537586936214;31135.37729245425;31366.215844603837;2127.680847872816;2155.6874253233195;2156.493224092337;2157.611629906616;2166.155199472207;20283.594328113355;20871;20882.89558552213;20898.686519702216;20952;2417.456072383717;2487.452760392711;2520.117958714435;2527.292358139724;2538.314655043128;155261;162011;162115.1894240533;162338;162503;14428;15577.688446231012;15579.610509737347;15690.372385104696;16131.516054518383;24120.63819042716;24338.148164814145;24431;24985.750142498706;25047.62428563573;10603.416812075257;10616.575336986589;10625.787484250426;10782;10863.893969834166;9785.412875227508;9827.606895724091;9872.654457094111;9894.55474503649;9953.502324883872;9654.75863103428;9848.71966644346;9883.456409897524;10072.1366547189;10231.539580718885;2688.193541937411;2699.8515081670303;2732.5764506501523;2794.4271424357958;2829.4765468388005;1056.8731752189785;1066.7653116314398;1073.9677809665723;1074.2641290715885;1078.1374900079904;21639;21872;21881.781182187973;21909.561808764054;21956.780432195792;1127.5827943660734;1137.4483375562845;1137.778133264022;1148.615213903335;1163.650904728578;11855.525778968744;12173.878261217451;12225.298062220743;12235.388230588434;12292.569760058534;619349;629788;658463;661208;665609;145830.27084864507;145863;146887;147141;149377;1323.483841301893;1328.813966044774;1359.5785306555;1371.519968011208;1373.8763511284033;22868.542629147658;23172.768272317735;23297.650535242323;23418.180363687872;23523.529529408974;68285.31714682988;70292.29707702858;70828.29171708217;70882;71152.64423677849;85011.57494212489;85287;86426;86440;87010.5649471774;15252.923735381251;15787.131707756183;15790.36838526446;15795.21023948775;15829.287682054566;25400.74599254058;25553.87223063947;25621;25755.197136200288;25969.870150649127;20332.17010469065;20686.482837929172;20939.685904711136;21089.57820843544;21104;18284.177212025756;18286.08569571543;18525.72211416857;18907;19075.236990520225;21556.353309400743;21603.675944860526;21731.674024889955;21860.562788744453;21945.231916882833;15344.462943796914;15517.612059698145;15561.76657350118;15618.219089045275;15639.296231669374;20729.481762956046;20733.27433539819;20770.48073798167;20875;20890 11:40:03 INFO - PID 18438 | |3;mootools.html;1404.1364560795112;1450.9274536273183;1470.9411623535057;1471.3526048538636;1473.1382141447245;15930.123843188634;16237.83762162378;16364.099974501398;16510.091944943022;16617.750733738972;15663;15881.285342159601;15899.205039747996;15904.204789760524;15922.601934951632;2589.443269697015;2697.0829917827937;2764.5853122031654;2767.6955534891144;2768.6816016158095;2699.325168707823;2736.5621500559914;2737.931551711203;2739.4384151248946;2743;2707.28257011892;2713.72862713729;2724.087430710704;2725.0734750184934;2725.7819374449996;2562.3466016165853;2573.9485210295784;2584.9224523264334;2594.6886373635098;2595.260350800032;2491.1405565080017;2498.71264804548;2517.509085728284;2523.1421316752394;2593.1831473085917;15985.040897546185;16105.516834494983;16111.758323625156;16131.516054518266;16133.27400266979;7826.530408175471;8059.274665280153;8059.597020148969;8074.838503229961;8089.150639182919;5055.545000949932;5057.974710126463;5094.668846525001;5211.140161873286;5226.268322434862;1922.5097600111883;1922.6539222939866;1930.5366711989022;1965.1746266568075;1994.182385222052;28583.28541786451;28618.14145575615;28720.71279287201;28839;28878.42243155125;6322.430981211713;6363.809085727436;6413.711382987777;6513.674316284261;6520.282768895418;19235;19278.614427711367;19289.90355048216;19338.806611933982;19367.225310987404;7724.420668449889;7873.881891771628;7886.72396466121;7887.250711182429;7890.289873911375;6199.225096862892;7064.434845212473;7197.388222001084;7262.854742905218;7330.450216233804;5182.4299327073995;5280.683159010472;5291.232771248147;5297.576193904479;5351.491608297206;1483.7403454395437;1487.9032862863878;1495.452206965807;1496.4089184771954;1524.1388615432245;921.9585118669676;939.3659279985982;941.4868896451451;945.4516380499294;951.9428834269966;7997.120316765151;8025.9598702006115;8035.156308587631;8087.919120808717;8136.959315203386;750.2160242546552;751.2750196060828;759.4304271796153;759.5936174146805;768.7271018788362;4945.727984960789;4951.356323677899;4994.250862370601;5461.508464238238;6005.249343832021;22788.43028924257;23812.88093559521;24049.7595024051;24050.15824446136;24090.759092409204;22942.8852855738;23314;23686;24261.39346516316;24568.877155614464;12433;12686.746265074647;12713.87286127127;12736.872631273754;12802.03984701151;9281.67514137002;9348.53257337144;9428.62285508572;9504.192143667866;9616.855747163938;20591.176352945713;20828.47928801792;20951;21348;21417.78582214158;21025.264115755876;21366.78633213648;21461.141554337653;21632.67550986768;21781.782182177976;12164.391780410768;12604.369781511072;12647.177933434297;12855.421506032064;13296.335183240994;15061.246937653294;15134.243287835785;15134.470293539673;15210.695786084438;15216.391344346102;11856.11079169083;11941;12023.21849079807;12094.939525302669;12103.394830258629;11758.470868810753;11796.88203117992;11880.584179553674;11993.34036627959;12015.939920300343;10466.16270698327;10471.738206544896;10719.517621706886;10816.837747433638;10824.67525974222;8416.621252043551;8524.914750852413;8545.615447304763;8591;8614.44006139599;7994.560299183368;8027.076886157933;8042;8059.717909873127;8202.589870506332 11:40:03 INFO - PID 18438 | |4;prototype.html;515.8117287190175;517.6919732759012;527.5331331771382;531.9787208511659;536.3001283325261;6147.477464415519;6168.920438923187;6181.28915174755;6207.131001659771;6236.63221860195;6088.786892458765;6090.482309003729;6100.206973093492;6146.293176284728;6172.135900973867;4850.587700045483;4855.732934688591;4876.902696893206;4877.463479017314;4880.829170979016;4681.9063618727605;4751.691140075884;4782.83260085897;4784.736839473828;4869.293952376903;4681;4737.123632128068;4743.193657078305;4796.280557916306;4806.663533552653;4723.763811809413;4737.620990320766;4743.881402964919;4760.476347601761;4790.640701947368;4176.874693759192;4277.786110694453;4312.3531470279395;4324.113556720865;4336.934945975813;5898.14476900847;5942.97028514859;5955.7915472958675;5957.136215248808;5966.343702192798;5654.717264136818;5721.885562288772;5751.856203594902;5756.7985120521;5768.903908257417;6543.1821022372205;6608;6617.162046013349;6626.73493060277;6635.834104147387;4823.807047718087;4848.9757551212015;4861.781219845116;4908.950910490885;4913.115639184945;6616;6645.867082658319;6747.414357625954;6839.521233513656;6900.723971041152;4989.800407983713;4999.75001249936;5008.544104567836;5042.218456139304;5049.671771334852;5128.7179205144075;5143.562797162208;5145.511176438307;5158.0199762045095;5165.638405311592;5643.830685079454;5664.575156863251;5667.603267771216;5752.712364381764;5758.3665796762325;6544;6569.868602627921;6572.638504882278;6613.503987200979;6617.602943823386;1784.9196786144655;1787.6514079754322;1791.2029147029707;1795.6678014567347;1797.469746424808;1195.229077245172;1233.3216730798026;1255.9623211303492;1265.0954567484293;1267.9175853569488;6292.46514046302;6293.496520278367;6305.432511074026;6312.305646378894;6347.428731414195;6740.696668649923;6759.831004224934;6773.322667733188;6776.15298087739;6783.626900520519;6265.8120256392385;6292.905606415908;6296.401841825019;6298.590591611531;6314.179156709598;3488.8430020648625;3557.8932632021083;3559.323728491578;3587.94618080729;3600.6939410149907;6994.950757386433;7052.541584796972;7079.504434689522;7099.538529995534;7107.111611048619;6363.150294072112;6769.830754231184;6887.210679674739;6898.965505172542;6936.549124306904;6765.627890465973;6928.263335982359;6966.442684585322;6975.093237879043;7006.824829379204;6546.149000630078;6563.671816409065;6585.949640970673;6626.4367528760595;6709.966450167718;6557.377049180321;6596.340365963365;6635.767748128792;6637.933620663732;6653.63405012729;6989.895151572832;6994.7759142150935;7032.1912980007955;7056.470764692771;7075.398591119812;5053.393592768891;5108.514691104339;5111.718855462986;5119.820806271762;5122.7449274927885;6516.837079073061;6624.867502650017;6699.296573859675;6816.931830681629;6845.5550389224545;6549.672516374067;6563.9343606563325;6582.637954912526;6583.111279977334;6594.604323740591;6582.868342633216;6599.0202939119035;6599.967000164968;6600.405963463311;6609.7771912196395;6549.805815052011;6554.967225163844;6576.8355791105605;6591.835204119935;6595.736170553316;6482.384173503509;6497.675116244074;6559.277899671582;6585.176852893388;6600.471962242913;6293.811185664437;6326.841828954313;6386.616802991835;6400.327965563549;6425.164728585254 11:40:03 INFO - PID 18438 | |5;yui.html;941.8401263760084;944.9763755906101;965.932384733069;966.1497881863959;985.4579981010445;19781.901090494564;20398;20417.387478375655;20442.89778551109;22016.44958876029;22430.887845560792;22696.319110426713;22729.54540909185;22735.658965115537;22742.65886011711;1002.4486532407184;1023.0996722883889;1023.626376372626;1027.4349107990613;1028.7942411517727;1041.1878734587035;1068.4230515521647;1083.9403832789194;1094.4527736131934;1100.4882729530766;1140.4012893231038;1140.948657310423;1141.549088110196;1142.3716955674347;1142.857142857143;1139.3164101539053;1139.3505701750005;1139.7378602921292;1142.9657110286664;1145.2441388683471;836.477201748907;836.9916300837035;837.5937670229933;839.49630221867;839.8908141941508;20760.37718868421;21123.894380528;21254.362369128798;21915.561688766134;22157.556848862932;21537.56924861494;21551.67672484914;21566.676499852358;21838.23566175176;22006.44983875416;16389.508314750576;16655.750163747554;16673.166341682987;16842.326306947707;16849.157542122844;3889.086064774776;3894.2990261752875;3897.629725176104;3898.4542164097047;3916.902077448058;149614;149908.2504587481;150315;150905;151911;17044.14779261032;17090.401835935932;17178.31286748516;17206.225719842638;17366.739498907526;34487.31025379529;34700.13249668779;34886.476702849475;35065.824670876485;35076.473852892224;8310.8337833243;8470.788230294293;8634.740957771277;8739.737807865775;8821.029686734453;4397.2085024695225;4414.227510185705;4453.777311134495;4490.079533695584;4496.595306422372;5709.571782116358;5795.710214489343;5852.209951656557;5903.203067585907;5927.9703601481715;1178.4107946026986;1186.0630102219322;1210.0622017935993;1215.611004478576;1219.0674134287278;724.1708244060521;746.3805041815281;747.7270796159471;751.0424209133398;765.7970637780993;13338.666533336744;13510.86489135096;13598.252096134807;14017;14375.137491750529;715.2561336210387;721.264310403396;723.1683563901555;725.9637018149072;733.9449541284425;6754.5947243165565;7234.493585448968;7246.96376518114;7267.818304542323;7273.0908636420445;130603;132640.3367983154;135543;140674;141789;115867;120663.99999999824;122325;123228;123485;108898.08484266898;110642.99999999838;111171.44414278038;112565;113193;12883.677908052;13809.240491772647;14023.80797632172;14164.362603682654;14199.787003194753;49364.75317623389;50071;50829.745851270505;51003;51542;84304.57847710722;86282;86777;88120.55939720261;88259.55870220608;18879.811201887806;18978.52553686169;19260;19412.514687132934;19510.60978780445;21439.142434302452;21608.67586986228;22631.434214144778;22699;25455;22450.10199591998;22903.88548057249;23092.191773287854;23618.763812361656;24123.51752964966;20481.795182048583;21950.560988779816;22214.888925555268;22928.4267893304;23162;19298.4210473686;19611.901940490778;19656.312029078912;19819.405417837486;21441.89279053595;12645.747085058063;13156.276404797827;13690;13897.930510347787;14903;15475.922620386826;16084.919575402047;16427.67144657124;16571.597118418;17503.21235544429 11:40:03 INFO - PID 18438 | __end_tp_report 11:40:03 INFO - PID 18438 | __start_cc_report 11:40:03 INFO - PID 18438 | _x_x_mozilla_cycle_collect,346 11:40:03 INFO - PID 18438 | __end_cc_report 11:40:03 INFO - PID 18438 | __startTimestamp1503168003851__endTimestamp 11:40:03 INFO - PID 18438 | 11:40:03 INFO - PID 18438 | ------- Summary: start ------- 11:40:03 INFO - PID 18438 | Number of tests: 6 11:40:03 INFO - PID 18438 | 11:40:03 INFO - PID 18438 | [#0] dojo.html Cycles:165 Average:6224.93 Median:6511.22 stddev:819.45 (12.6%) stddev-sans-first:791.98 11:40:03 INFO - PID 18438 | Values: 3424.8 3502.3 3505.1 3508.7 3529.9 6169.8 6253.5 6286.5 6303.1 6323.6 6135.3 6154.8 6174.2 6245.2 6261.8 5422.7 5434.4 5444.9 5487.8 5590.1 5568.6 5595.3 5602.5 5615.2 5632.2 5451.3 5506.4 5518.7 5601.7 5605.7 5334.8 5421.4 5467.2 5469.3 5545.5 5440.8 5462.9 5499.5 5522.6 5527.8 6047.6 6118.4 6138.1 6155.3 6188.5 6676.3 6708.9 6712.1 6741.5 6749.7 6829.9 6838.8 6842.0 6845.2 6848.2 6299.7 6308.5 6373.6 6382.9 6396.9 6999.4 7008.5 7010.9 7090.1 7106.8 6511.9 6677.6 6709.3 6751.0 6758.3 6654.2 6723.2 6882.6 6884.6 6888.9 6768.5 6770.7 6834.2 6845.6 6857.3 6800.2 6807.6 6877.2 6881.4 6881.6 4799.9 4814.3 4876.1 4895.8 4906.2 4329.4 4342.7 4354.3 4363.3 4368.3 6401.3 6406.7 6485.3 6489.4 6492.9 6715.8 6790.0 6875.8 6901.9 6920.7 6407.1 6413.9 6466.5 6483.3 6484.9 5400.5 5444.3 5505.3 5515.4 5541.8 6952.7 7033.0 7069.1 7163.1 7170.6 6738.3 6773.0 6804.8 6846.5 6848.5 6975.3 6988.8 7016.6 7097.8 7108.9 6390.8 6507.3 6571.4 6665.4 6688.7 6799.3 6819.9 6822.3 6857.1 6888.1 6443.9 6535.8 6586.1 6605.6 6672.2 6467.0 6586.3 6592.0 6669.0 6673.9 6528.0 6596.3 6597.1 6611.7 6668.3 6641.5 6642.5 6681.4 6731.7 6742.1 6406.3 6412.2 6428.8 6511.2 6561.0 11:40:03 INFO - PID 18438 | 11:40:03 INFO - PID 18438 | [#1] ext.html Cycles:180 Average:40367.49 Median:34961.24 stddev:59383.74 (169.9%) stddev-sans-first:59476.32 11:40:03 INFO - PID 18438 | Values: 881.6 904.1 926.5 956.6 958.5 41417.9 42091.6 42196.8 42292.6 42333.0 39214.8 39216.6 39419.6 39572.6 39594.8 6901.6 7014.7 7015.5 7016.9 7017.5 6877.8 6958.9 6977.4 6979.5 6985.4 6916.7 6921.2 6929.8 6936.1 6939.2 6889.4 6894.4 6920.6 6927.2 6928.2 6337.5 6375.6 6394.2 6396.8 6398.0 34231.3 34520.0 34523.7 34524.7 34540.3 3329.0 3348.5 3368.7 3368.7 3369.5 27297.5 27389.5 27393.7 27551.7 27569.9 4496.7 4563.5 4578.0 4603.7 4605.1 201715.0 203187.0 203497.0 205597.0 214352.0 51378.2 51393.7 51434.0 51576.7 51683.0 54318.2 54452.7 54654.5 54700.5 54794.7 15718.8 15794.8 15830.4 15854.6 15941.7 13060.9 13064.9 13069.3 13071.3 13071.4 13709.8 13775.1 13843.5 13878.7 13926.2 5561.0 5584.4 5650.5 5696.2 5699.1 1075.5 1078.5 1082.7 1096.7 1101.4 24214.6 24577.6 24609.6 24633.0 24651.8 1175.5 1197.6 1208.9 1210.5 1212.2 12687.6 12783.7 13014.2 13051.3 13103.3 254296.0 254435.0 254675.0 254752.0 255789.0 53778.2 53989.0 54106.7 54170.5 54221.7 1496.7 1506.5 1515.5 1516.2 1552.0 24250.9 29070.6 29357.7 30021.0 30678.0 52480.0 52505.5 52520.5 52703.7 52824.5 220580.0 221297.0 221393.0 222175.0 222678.0 34284.7 34795.7 36646.3 37061.3 37066.8 47026.3 47484.5 47531.0 47632.0 48133.3 34776.0 34982.0 35041.6 35360.8 35769.0 34507.1 34901.8 34940.5 35156.3 35743.5 39505.6 40261.6 40410.2 40411.6 40417.4 33365.3 33792.2 33951.7 34002.3 34197.8 25596.6 25690.9 25842.6 25916.2 26306.7 11:40:03 INFO - PID 18438 | 11:40:03 INFO - PID 18438 | [#2] jquery.html Cycles:180 Average:42285.33 Median:23235.21 stddev:108611.30 (467.4%) stddev-sans-first:108870.83 11:40:03 INFO - PID 18438 | Values: 570.7 574.5 576.5 578.2 586.4 22053.6 22739.7 23319.3 23452.2 23459.2 27132.9 27489.0 27659.4 27667.7 27696.6 6295.4 6426.7 6433.1 6434.5 6446.7 5751.9 6202.9 6249.3 6253.5 6430.0 6206.3 6214.1 6220.1 6229.4 6230.5 6216.1 6223.2 6229.1 6234.5 6235.8 5771.8 5798.6 5801.7 5801.8 5809.4 29938.9 30789.8 30827.5 31135.4 31366.2 2127.7 2155.7 2156.5 2157.6 2166.2 20283.6 20871.0 20882.9 20898.7 20952.0 2417.5 2487.5 2520.1 2527.3 2538.3 155261.0 162011.0 162115.2 162338.0 162503.0 14428.0 15577.7 15579.6 15690.4 16131.5 24120.6 24338.1 24431.0 24985.8 25047.6 10603.4 10616.6 10625.8 10782.0 10863.9 9785.4 9827.6 9872.7 9894.6 9953.5 9654.8 9848.7 9883.5 10072.1 10231.5 2688.2 2699.9 2732.6 2794.4 2829.5 1056.9 1066.8 1074.0 1074.3 1078.1 21639.0 21872.0 21881.8 21909.6 21956.8 1127.6 1137.4 1137.8 1148.6 1163.7 11855.5 12173.9 12225.3 12235.4 12292.6 619349.0 629788.0 658463.0 661208.0 665609.0 145830.3 145863.0 146887.0 147141.0 149377.0 1323.5 1328.8 1359.6 1371.5 1373.9 22868.5 23172.8 23297.7 23418.2 23523.5 68285.3 70292.3 70828.3 70882.0 71152.6 85011.6 85287.0 86426.0 86440.0 87010.6 15252.9 15787.1 15790.4 15795.2 15829.3 25400.7 25553.9 25621.0 25755.2 25969.9 20332.2 20686.5 20939.7 21089.6 21104.0 18284.2 18286.1 18525.7 18907.0 19075.2 21556.4 21603.7 21731.7 21860.6 21945.2 15344.5 15517.6 15561.8 15618.2 15639.3 20729.5 20733.3 20770.5 20875.0 20890.0 11:40:03 INFO - PID 18438 | 11:40:03 INFO - PID 18438 | [#3] mootools.html Cycles:180 Average:10009.90 Median:2579.44 stddev:7449.20 (288.8%) stddev-sans-first:7442.04 11:40:03 INFO - PID 18438 | Values: 1404.1 1450.9 1470.9 1471.4 1473.1 15930.1 16237.8 16364.1 16510.1 16617.8 15663.0 15881.3 15899.2 15904.2 15922.6 2589.4 2697.1 2764.6 2767.7 2768.7 2699.3 2736.6 2737.9 2739.4 2743.0 2707.3 2713.7 2724.1 2725.1 2725.8 2562.3 2573.9 2584.9 2594.7 2595.3 2491.1 2498.7 2517.5 2523.1 2593.2 15985.0 16105.5 16111.8 16131.5 16133.3 7826.5 8059.3 8059.6 8074.8 8089.2 5055.5 5058.0 5094.7 5211.1 5226.3 1922.5 1922.7 1930.5 1965.2 1994.2 28583.3 28618.1 28720.7 28839.0 28878.4 6322.4 6363.8 6413.7 6513.7 6520.3 19235.0 19278.6 19289.9 19338.8 19367.2 7724.4 7873.9 7886.7 7887.3 7890.3 6199.2 7064.4 7197.4 7262.9 7330.5 5182.4 5280.7 5291.2 5297.6 5351.5 1483.7 1487.9 1495.5 1496.4 1524.1 922.0 939.4 941.5 945.5 951.9 7997.1 8026.0 8035.2 8087.9 8137.0 750.2 751.3 759.4 759.6 768.7 4945.7 4951.4 4994.3 5461.5 6005.2 22788.4 23812.9 24049.8 24050.2 24090.8 22942.9 23314.0 23686.0 24261.4 24568.9 12433.0 12686.7 12713.9 12736.9 12802.0 9281.7 9348.5 9428.6 9504.2 9616.9 20591.2 20828.5 20951.0 21348.0 21417.8 21025.3 21366.8 21461.1 21632.7 21781.8 12164.4 12604.4 12647.2 12855.4 13296.3 15061.2 15134.2 15134.5 15210.7 15216.4 11856.1 11941.0 12023.2 12094.9 12103.4 11758.5 11796.9 11880.6 11993.3 12015.9 10466.2 10471.7 10719.5 10816.8 10824.7 8416.6 8524.9 8545.6 8591.0 8614.4 7994.6 8027.1 8042.0 8059.7 8202.6 11:40:03 INFO - PID 18438 | 11:40:03 INFO - PID 18438 | [#4] prototype.html Cycles:180 Average:5557.25 Median:6279.14 stddev:1590.17 (25.3%) stddev-sans-first:1548.96 11:40:03 INFO - PID 18438 | Values: 515.8 517.7 527.5 532.0 536.3 6147.5 6168.9 6181.3 6207.1 6236.6 6088.8 6090.5 6100.2 6146.3 6172.1 4850.6 4855.7 4876.9 4877.5 4880.8 4681.9 4751.7 4782.8 4784.7 4869.3 4681.0 4737.1 4743.2 4796.3 4806.7 4723.8 4737.6 4743.9 4760.5 4790.6 4176.9 4277.8 4312.4 4324.1 4336.9 5898.1 5943.0 5955.8 5957.1 5966.3 5654.7 5721.9 5751.9 5756.8 5768.9 6543.2 6608.0 6617.2 6626.7 6635.8 4823.8 4849.0 4861.8 4909.0 4913.1 6616.0 6645.9 6747.4 6839.5 6900.7 4989.8 4999.8 5008.5 5042.2 5049.7 5128.7 5143.6 5145.5 5158.0 5165.6 5643.8 5664.6 5667.6 5752.7 5758.4 6544.0 6569.9 6572.6 6613.5 6617.6 1784.9 1787.7 1791.2 1795.7 1797.5 1195.2 1233.3 1256.0 1265.1 1267.9 6292.5 6293.5 6305.4 6312.3 6347.4 6740.7 6759.8 6773.3 6776.2 6783.6 6265.8 6292.9 6296.4 6298.6 6314.2 3488.8 3557.9 3559.3 3587.9 3600.7 6995.0 7052.5 7079.5 7099.5 7107.1 6363.2 6769.8 6887.2 6899.0 6936.5 6765.6 6928.3 6966.4 6975.1 7006.8 6546.1 6563.7 6585.9 6626.4 6710.0 6557.4 6596.3 6635.8 6637.9 6653.6 6989.9 6994.8 7032.2 7056.5 7075.4 5053.4 5108.5 5111.7 5119.8 5122.7 6516.8 6624.9 6699.3 6816.9 6845.6 6549.7 6563.9 6582.6 6583.1 6594.6 6582.9 6599.0 6600.0 6600.4 6609.8 6549.8 6555.0 6576.8 6591.8 6595.7 6482.4 6497.7 6559.3 6585.2 6600.5 6293.8 6326.8 6386.6 6400.3 6425.2 11:40:03 INFO - PID 18438 | 11:40:03 INFO - PID 18438 | [#5] yui.html Cycles:180 Average:28205.43 Median:21189.13 stddev:39822.30 (187.9%) stddev-sans-first:39881.40 11:40:03 INFO - PID 18438 | Values: 941.8 945.0 965.9 966.1 985.5 19781.9 20398.0 20417.4 20442.9 22016.4 22430.9 22696.3 22729.5 22735.7 22742.7 1002.4 1023.1 1023.6 1027.4 1028.8 1041.2 1068.4 1083.9 1094.5 1100.5 1140.4 1140.9 1141.5 1142.4 1142.9 1139.3 1139.4 1139.7 1143.0 1145.2 836.5 837.0 837.6 839.5 839.9 20760.4 21123.9 21254.4 21915.6 22157.6 21537.6 21551.7 21566.7 21838.2 22006.4 16389.5 16655.8 16673.2 16842.3 16849.2 3889.1 3894.3 3897.6 3898.5 3916.9 149614.0 149908.3 150315.0 150905.0 151911.0 17044.1 17090.4 17178.3 17206.2 17366.7 34487.3 34700.1 34886.5 35065.8 35076.5 8310.8 8470.8 8634.7 8739.7 8821.0 4397.2 4414.2 4453.8 4490.1 4496.6 5709.6 5795.7 5852.2 5903.2 5928.0 1178.4 1186.1 1210.1 1215.6 1219.1 724.2 746.4 747.7 751.0 765.8 13338.7 13510.9 13598.3 14017.0 14375.1 715.3 721.3 723.2 726.0 733.9 6754.6 7234.5 7247.0 7267.8 7273.1 130603.0 132640.3 135543.0 140674.0 141789.0 115867.0 120664.0 122325.0 123228.0 123485.0 108898.1 110643.0 111171.4 112565.0 113193.0 12883.7 13809.2 14023.8 14164.4 14199.8 49364.8 50071.0 50829.7 51003.0 51542.0 84304.6 86282.0 86777.0 88120.6 88259.6 18879.8 18978.5 19260.0 19412.5 19510.6 21439.1 21608.7 22631.4 22699.0 25455.0 22450.1 22903.9 23092.2 23618.8 24123.5 20481.8 21950.6 22214.9 22928.4 23162.0 19298.4 19611.9 19656.3 19819.4 21441.9 12645.7 13156.3 13690.0 13897.9 14903.0 15475.9 16084.9 16427.7 16571.6 17503.2 11:40:03 INFO - PID 18438 | -------- Summary: end -------- 11:40:03 INFO - PID 18438 | 11:40:04 INFO - TEST-INFO | 18438: exit 0 11:40:04 INFO - TEST-OK | dromaeo_css | took 1108676ms 11:40:04 INFO - TEST-START | kraken 11:40:04 INFO - Initialising browser for kraken test... 11:40:04 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:39932/getInfo.html -profile /tmp/tmpS05cO3/profile 11:40:04 INFO - TEST-INFO | started process 18854 (/builds/slave/test/build/application/firefox/firefox http://localhost:39932/getInfo.html) 11:40:09 INFO - TEST-INFO | 18854: exit 0 11:40:10 INFO - Browser initialized. 11:40:10 INFO - Running cycle 1/1 for kraken test... 11:40:10 INFO - TEST-INFO | started process 19029 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpS05cO3/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 11:40:10 INFO - PID 19029 | 11:40:10 INFO - PID 19029 | (/builds/slave/test/build/application/firefox/firefox:19079): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 11:40:10 INFO - PID 19029 | 11:40:11 INFO - PID 19029 | 11:40:11 INFO - PID 19029 | (/builds/slave/test/build/application/firefox/firefox:19133): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 11:40:11 INFO - PID 19029 | 11:40:11 INFO - PID 19029 | __metrics Screen width/height:1600/1200 11:40:11 INFO - PID 19029 | colorDepth:24 11:40:11 INFO - PID 19029 | Browser inner width/height: 1024/768 11:40:11 INFO - PID 19029 | __metrics 11:40:21 INFO - PID 19029 | RSS: Main: 165584896 11:40:21 INFO - PID 19029 | 11:40:23 INFO - PID 19029 | Cycle 1(1): loaded http://localhost:39932/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:39932/tests/kraken/driver.html?testName=audio-beat-detection) 11:40:24 INFO - PID 19029 | RSS: Main: 169869312 11:40:24 INFO - PID 19029 | 11:40:27 INFO - PID 19029 | Cycle 1(1): loaded http://localhost:39932/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:39932/tests/kraken/driver.html?testName=audio-dft) 11:40:27 INFO - PID 19029 | RSS: Main: 172228608 11:40:27 INFO - PID 19029 | 11:40:30 INFO - PID 19029 | Cycle 1(1): loaded http://localhost:39932/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:39932/tests/kraken/driver.html?testName=audio-fft) 11:40:31 INFO - PID 19029 | RSS: Main: 164921344 11:40:31 INFO - PID 19029 | 11:40:33 INFO - PID 19029 | Cycle 1(1): loaded http://localhost:39932/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:39932/tests/kraken/driver.html?testName=audio-oscillator) 11:40:34 INFO - PID 19029 | RSS: Main: 165900288 11:40:34 INFO - PID 19029 | 11:40:36 INFO - PID 19029 | Cycle 1(1): loaded http://localhost:39932/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:39932/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:40:36 INFO - PID 19029 | RSS: Main: 165822464 11:40:36 INFO - PID 19029 | 11:40:39 INFO - PID 19029 | Cycle 1(1): loaded http://localhost:39932/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:39932/tests/kraken/driver.html?testName=imaging-darkroom) 11:40:40 INFO - PID 19029 | RSS: Main: 167321600 11:40:40 INFO - PID 19029 | 11:40:43 INFO - PID 19029 | Cycle 1(1): loaded http://localhost:39932/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:39932/tests/kraken/driver.html?testName=imaging-desaturate) 11:40:44 INFO - PID 19029 | RSS: Main: 169140224 11:40:44 INFO - PID 19029 | 11:40:47 INFO - PID 19029 | Cycle 1(1): loaded http://localhost:39932/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:39932/tests/kraken/driver.html?testName=json-parse-financial) 11:40:47 INFO - PID 19029 | RSS: Main: 168304640 11:40:47 INFO - PID 19029 | 11:40:49 INFO - PID 19029 | Cycle 1(1): loaded http://localhost:39932/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:39932/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:40:50 INFO - PID 19029 | RSS: Main: 167886848 11:40:50 INFO - PID 19029 | 11:40:51 INFO - PID 19029 | Cycle 1(1): loaded http://localhost:39932/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:39932/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:40:52 INFO - PID 19029 | RSS: Main: 167841792 11:40:52 INFO - PID 19029 | 11:40:54 INFO - PID 19029 | Cycle 1(1): loaded http://localhost:39932/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:39932/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:40:55 INFO - PID 19029 | RSS: Main: 167780352 11:40:55 INFO - PID 19029 | 11:40:57 INFO - PID 19029 | Cycle 1(1): loaded http://localhost:39932/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:39932/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:40:58 INFO - PID 19029 | RSS: Main: 167800832 11:40:58 INFO - PID 19029 | 11:41:01 INFO - PID 19029 | Cycle 1(1): loaded http://localhost:39932/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:39932/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:41:01 INFO - PID 19029 | RSS: Main: 168181760 11:41:01 INFO - PID 19029 | 11:41:03 INFO - PID 19029 | Cycle 1(1): loaded http://localhost:39932/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:39932/tests/kraken/driver.html?testName=ai-astar) 11:41:03 INFO - PID 19029 | RSS: Main: 169795584 11:41:03 INFO - PID 19029 | 11:41:03 INFO - PID 19029 | __start_tp_report 11:41:03 INFO - PID 19029 | _x_x_mozilla_page_load 11:41:03 INFO - PID 19029 | _x_x_mozilla_page_load_details 11:41:03 INFO - PID 19029 | |i|pagename|runs| 11:41:03 INFO - PID 19029 | |0;ai-astar;107;107;98;110;106;106;107;100;107;108 11:41:03 INFO - PID 19029 | |1;audio-beat-detection;143;113;142;159;114;144;141;115;172;125 11:41:03 INFO - PID 19029 | |2;audio-dft;164;163;163;161;163;164;162;163;170;169 11:41:03 INFO - PID 19029 | |3;audio-fft;73;73;73;118;73;75;74;92;95;75 11:41:03 INFO - PID 19029 | |4;audio-oscillator;85;78;134;79;78;79;127;78;77;124 11:41:03 INFO - PID 19029 | |5;imaging-gaussian-blur;115;114;113;116;117;114;113;114;113;113 11:41:03 INFO - PID 19029 | |6;imaging-darkroom;146;148;147;147;147;147;147;148;147;148 11:41:03 INFO - PID 19029 | |7;imaging-desaturate;94;95;95;94;93;94;102;93;95;94 11:41:03 INFO - PID 19029 | |8;json-parse-financial;47;47;47;47;47;47;49;48;48;48 11:41:03 INFO - PID 19029 | |9;json-stringify-tinderbox;54;55;54;54;54;54;54;55;54;55 11:41:03 INFO - PID 19029 | |10;stanford-crypto-aes;72;73;72;73;72;74;72;72;72;71 11:41:03 INFO - PID 19029 | |11;stanford-crypto-ccm;114;117;113;119;113;116;113;114;113;156 11:41:03 INFO - PID 19029 | |12;stanford-crypto-pbkdf2;161;161;162;171;165;166;164;164;162;159 11:41:03 INFO - PID 19029 | |13;stanford-crypto-sha256-iterative;62;69;60;63;62;61;59;63;60;68 11:41:03 INFO - PID 19029 | __end_tp_report 11:41:03 INFO - PID 19029 | __start_cc_report 11:41:03 INFO - PID 19029 | _x_x_mozilla_cycle_collect,873 11:41:03 INFO - PID 19029 | __end_cc_report 11:41:03 INFO - PID 19029 | __startTimestamp1503168063621__endTimestamp 11:41:03 INFO - PID 19029 | 11:41:03 INFO - PID 19029 | ------- Summary: start ------- 11:41:03 INFO - PID 19029 | Number of tests: 14 11:41:03 INFO - PID 19029 | 11:41:03 INFO - PID 19029 | [#0] ai-astar Cycles:10 Average:105.60 Median:107.00 stddev:3.69 (3.4%) stddev-sans-first:3.88 11:41:03 INFO - PID 19029 | Values: 107.0 107.0 98.0 110.0 106.0 106.0 107.0 100.0 107.0 108.0 11:41:03 INFO - PID 19029 | 11:41:03 INFO - PID 19029 | [#1] audio-beat-detection Cycles:10 Average:136.80 Median:142.50 stddev:19.91 (14.0%) stddev-sans-first:20.99 11:41:03 INFO - PID 19029 | Values: 143.0 113.0 142.0 159.0 114.0 144.0 141.0 115.0 172.0 125.0 11:41:03 INFO - PID 19029 | 11:41:03 INFO - PID 19029 | [#2] audio-dft Cycles:10 Average:164.20 Median:163.50 stddev:2.94 (1.8%) stddev-sans-first:3.11 11:41:03 INFO - PID 19029 | Values: 164.0 163.0 163.0 161.0 163.0 164.0 162.0 163.0 170.0 169.0 11:41:03 INFO - PID 19029 | 11:41:03 INFO - PID 19029 | [#3] audio-fft Cycles:10 Average:82.10 Median:74.50 stddev:15.10 (20.3%) stddev-sans-first:15.65 11:41:03 INFO - PID 19029 | Values: 73.0 73.0 73.0 118.0 73.0 75.0 74.0 92.0 95.0 75.0 11:41:03 INFO - PID 19029 | 11:41:03 INFO - PID 19029 | [#4] audio-oscillator Cycles:10 Average:93.90 Median:78.00 stddev:23.98 (30.7%) stddev-sans-first:25.22 11:41:03 INFO - PID 19029 | Values: 85.0 78.0 134.0 79.0 78.0 79.0 127.0 78.0 77.0 124.0 11:41:03 INFO - PID 19029 | 11:41:03 INFO - PID 19029 | [#5] imaging-gaussian-blur Cycles:10 Average:114.20 Median:114.00 stddev:1.40 (1.2%) stddev-sans-first:1.45 11:41:03 INFO - PID 19029 | Values: 115.0 114.0 113.0 116.0 117.0 114.0 113.0 114.0 113.0 113.0 11:41:03 INFO - PID 19029 | 11:41:03 INFO - PID 19029 | [#6] imaging-darkroom Cycles:10 Average:147.20 Median:147.00 stddev:0.63 (0.4%) stddev-sans-first:0.50 11:41:03 INFO - PID 19029 | Values: 146.0 148.0 147.0 147.0 147.0 147.0 147.0 148.0 147.0 148.0 11:41:03 INFO - PID 19029 | 11:41:03 INFO - PID 19029 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:94.00 stddev:2.60 (2.8%) stddev-sans-first:2.74 11:41:03 INFO - PID 19029 | Values: 94.0 95.0 95.0 94.0 93.0 94.0 102.0 93.0 95.0 94.0 11:41:03 INFO - PID 19029 | 11:41:03 INFO - PID 19029 | [#8] json-parse-financial Cycles:10 Average:47.50 Median:47.50 stddev:0.71 (1.5%) stddev-sans-first:0.73 11:41:03 INFO - PID 19029 | Values: 47.0 47.0 47.0 47.0 47.0 47.0 49.0 48.0 48.0 48.0 11:41:03 INFO - PID 19029 | 11:41:03 INFO - PID 19029 | [#9] json-stringify-tinderbox Cycles:10 Average:54.30 Median:54.00 stddev:0.48 (0.9%) stddev-sans-first:0.50 11:41:03 INFO - PID 19029 | Values: 54.0 55.0 54.0 54.0 54.0 54.0 54.0 55.0 54.0 55.0 11:41:03 INFO - PID 19029 | 11:41:03 INFO - PID 19029 | [#10] stanford-crypto-aes Cycles:10 Average:72.30 Median:72.00 stddev:0.82 (1.1%) stddev-sans-first:0.87 11:41:03 INFO - PID 19029 | Values: 72.0 73.0 72.0 73.0 72.0 74.0 72.0 72.0 72.0 71.0 11:41:03 INFO - PID 19029 | 11:41:03 INFO - PID 19029 | [#11] stanford-crypto-ccm Cycles:10 Average:118.80 Median:115.00 stddev:13.23 (11.5%) stddev-sans-first:13.92 11:41:03 INFO - PID 19029 | Values: 114.0 117.0 113.0 119.0 113.0 116.0 113.0 114.0 113.0 156.0 11:41:03 INFO - PID 19029 | 11:41:03 INFO - PID 19029 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:163.50 Median:164.00 stddev:3.37 (2.1%) stddev-sans-first:3.46 11:41:03 INFO - PID 19029 | Values: 161.0 161.0 162.0 171.0 165.0 166.0 164.0 164.0 162.0 159.0 11:41:03 INFO - PID 19029 | 11:41:03 INFO - PID 19029 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.70 Median:62.50 stddev:3.33 (5.3%) stddev-sans-first:3.53 11:41:03 INFO - PID 19029 | Values: 62.0 69.0 60.0 63.0 62.0 61.0 59.0 63.0 60.0 68.0 11:41:03 INFO - PID 19029 | -------- Summary: end -------- 11:41:03 INFO - PID 19029 | 11:41:03 INFO - PID 19029 | 11:41:03 INFO - PID 19029 | ###!!! [Parent][MessageChannel] Error: (msgtype=0x150079,name=PBrowser::Msg_Destroy) Closed channel: cannot send/recv 11:41:03 INFO - PID 19029 | 11:41:03 INFO - PID 19029 | 11:41:03 INFO - PID 19029 | ###!!! [Child][MessageChannel] Error: (msgtype=0x150001,name=PBrowser::Msg_AsyncMessage) Closed channel: cannot send/recv 11:41:03 INFO - PID 19029 | 11:41:04 INFO - PID 19029 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 11:41:04 INFO - TEST-INFO | 19029: exit 0 11:41:04 INFO - TEST-OK | kraken | took 59850ms 11:41:04 INFO - SUITE-END | took 1168s 11:41:04 INFO - Completed test suite (00:19:28) 11:41:04 INFO - javascript benchmark 11:41:04 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8936.675023618276, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3424.8458819353127, 3502.299540091982, 3505.0711561436215, 3508.6842184203424, 3529.9117522061947, 6169.784057557987, 6253.499720022399, 6286.528510361718, 6303.054541818729, 6323.5889667171605, 6135.29444113927, 6154.784582539612, 6174.197354343929, 6245.219347581552, 6261.780837670683, 5422.728863556807, 5434.429384914567, 5444.945550544503, 5487.835364939058, 5590.105583106703, 5568.55451563876, 5595.300587426572, 5602.523785478239, 5615.157726341041, 5632.183333416652, 5451.3458384994055, 5506.449355064502, 5518.724063796794, 5601.719914004304, 5605.691686957216, 5334.759935802898, 5421.376541697716, 5467.152591348347, 5469.316335458067, 5545.473180047889, 5440.809571665012, 5462.890742185174, 5499.450054994509, 5522.5581953443625, 5527.806526771544, 6047.5766696331275, 6118.418750218722, 6138.14066030756, 6155.322914479404, 6188.504919606421, 6676.298988606175, 6708.932910670879, 6712.127423434971, 6741.494387920926, 6749.7300107995625, 6829.931700683029, 6838.829029274259, 6841.965790171017, 6845.178578570553, 6848.212455567574, 6299.716512756937, 6308.463780578656, 6373.617582944992, 6382.904256436157, 6396.904046439307, 6999.440044796404, 7008.509404341749, 7010.859782804316, 7090.078289822393, 7106.751263705745, 6511.9348806511325, 6677.599344039373, 6709.329067093252, 6750.966245168841, 6758.256591774901, 6654.168228971379, 6723.226828914738, 6882.621455819878, 6884.621345825927, 6888.931110688929, 6768.526203165829, 6770.661466926634, 6834.2482326944, 6845.623490707959, 6857.27998560154, 6800.183977922582, 6807.5575087619145, 6877.243503214642, 6881.41507971818, 6881.621510816853, 4799.856004319876, 4814.253790662453, 4876.146674331978, 4895.755212239374, 4906.165951788204, 4329.350597410351, 4342.717723348035, 4354.346847972829, 4363.323684828857, 4368.27923392643, 6401.295857455676, 6406.743730250738, 6485.319041500669, 6489.448396886223, 6492.902606460907, 6715.832104197434, 6789.966050169816, 6875.759348422881, 6901.930980690129, 6920.653967301615, 6407.103005579223, 6413.903791443132, 6466.482681385478, 6483.3192514786215, 6484.902726459107, 5400.540954018952, 5444.346678398539, 5505.311836020497, 5515.393306736256, 5541.833744987657, 6952.687129079203, 7033.0, 7069.08101946754, 7163.06880105583, 7170.569765814068, 6738.258791533026, 6773.017912402773, 6804.795856124225, 6846.486513511407, 6848.486363522656, 6975.267596902455, 6988.825279368057, 7016.579005259497, 7097.787066388017, 7108.9289107110335, 6390.808275751735, 6507.316731743288, 6571.408573228432, 6665.433438157617, 6688.7324507019175, 6799.252082271045, 6819.863602728017, 6822.317768223138, 6857.142857142857, 6888.070110535214, 6443.871122577429, 6535.803925882231, 6586.110875032001, 6605.603663780189, 6672.232693240146, 6467.029945508211, 6586.341365863375, 6592.0, 6669.0329902164885, 6673.933260667525, 6527.967360163168, 6596.274409815012, 6597.0764093026055, 6611.66941652925, 6668.333166683293, 6641.50188735837, 6642.4686025118845, 6681.365270299314, 6731.663416829237, 6742.08981787472, 6406.295307516262, 6412.23053233615, 6428.807135785747, 6511.218653761579, 6560.967195163994], "value": 6161.131243274027, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [881.5825481840571, 904.0733248420369, 926.4996901673097, 956.5504213019879, 958.5399008475931, 41417.92910354482, 42091.57908420915, 42196.789016054914, 42292.57707422925, 42333.0, 39214.8039259804, 39216.607833921655, 39419.60580394195, 39572.60427395725, 39594.80202598983, 6901.6204108774, 7014.719411223545, 7015.543989640657, 7016.929830701679, 7017.473689473284, 6877.793666190022, 6958.930410695879, 6977.406920411746, 6979.511434199608, 6985.371316581507, 6916.688749006282, 6921.204061532938, 6929.826754331131, 6936.063631409771, 6939.23668396476, 6889.414399776025, 6894.448444124458, 6920.619365934872, 6927.203371612279, 6928.203256625477, 6337.524685648548, 6375.617462952191, 6394.168758061469, 6396.840078998016, 6398.0, 34231.315373692385, 34520.0, 34523.654763452294, 34524.65475345239, 34540.309193815985, 3329.0, 3348.464245720673, 3368.6631336866362, 3368.7473439492137, 3369.528266042756, 27297.45405091907, 27389.45221095567, 27393.726062739515, 27551.724482755315, 27569.862150689318, 4496.730196188207, 4563.452385713703, 4577.954220457819, 4603.723776573416, 4605.0559635274685, 201715.0, 203187.0, 203497.0, 205597.0, 214352.0, 51378.22932656013, 51393.743031285354, 51434.0, 51576.742116289926, 51683.0, 54318.18522722162, 54452.727736361856, 54654.45345546573, 54700.45299547033, 54794.726026369615, 15718.842811571738, 15794.763078553831, 15830.44593439224, 15854.603634908988, 15941.681166376608, 13060.934695326652, 13064.869351306364, 13069.281189534668, 13071.281079540526, 13071.41178646963, 13709.794353084711, 13775.104618199784, 13843.515476958259, 13878.653033674036, 13926.164430134224, 5560.972195138998, 5584.413636568183, 5650.5479561634975, 5696.174054762037, 5699.088145896637, 1075.4622688655672, 1078.4931082391263, 1082.6697857153645, 1096.6709987003867, 1101.372217835826, 24214.63678044831, 24577.631335529983, 24609.63085553718, 24633.0, 24651.753482465305, 1175.506287359311, 1197.6167426820564, 1208.9214201076902, 1210.4613447015993, 1212.2241765270235, 12687.619371418872, 12783.744325113446, 13014.15407998477, 13051.28217948003, 13103.27931963732, 254296.0, 254435.0, 254675.0, 254752.0, 255789.0, 53778.193327100125, 53989.0, 54106.729466352415, 54170.45829541733, 54221.72889135529, 1496.6931778985281, 1506.5254444849836, 1515.5226103777275, 1516.196415899575, 1551.95344139676, 24250.87874560616, 29070.56394154047, 29357.7064229355, 30021.0, 30678.0, 52480.0, 52505.47494525006, 52520.47479525156, 52703.73648131735, 52824.47175528196, 220580.0, 221297.0, 221393.0, 222175.0, 222678.0, 34284.65715342815, 34795.65204348025, 36646.26707465889, 37061.258774823815, 37066.8146659265, 47026.29460558026, 47484.52515474939, 47531.0, 47632.0, 48133.278000830716, 34776.0, 34982.0, 35041.649583504855, 35360.82319588386, 35769.0, 34507.13732156716, 34901.82549087238, 34940.47589286112, 35156.29687406187, 35743.46384804178, 39505.604943950195, 40261.59738402579, 40410.1917961645, 40411.595884040784, 40417.39373909453, 33365.33269334551, 33792.241551690255, 33951.66048339485, 34002.31995360128, 34197.829010855785, 25596.616050759625, 25690.871545642152, 25842.612360814226, 25916.219932641474, 26306.73693263043], "value": 17582.577921126915, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [570.6975303089363, 574.4772257245907, 576.5358886096693, 578.1587789765891, 586.3637952821189, 22053.558928821414, 22739.658905116437, 23319.300420987398, 23452.179173728902, 23459.178928737478, 27132.864335678343, 27488.99999999995, 27659.446811063768, 27667.723322766768, 27696.584551231746, 6295.370462953702, 6426.710798014101, 6433.099366088752, 6434.517411194156, 6446.709898054575, 5751.856203594902, 6202.937970620281, 6249.3438188990185, 6253.53098517613, 6429.967850160766, 6206.255249370082, 6214.067889816519, 6220.098085777559, 6229.439350458458, 6230.532710046742, 6216.067589861512, 6223.159873417076, 6229.065640153991, 6234.470070044052, 6235.812925612239, 5771.797987070432, 5798.594098413113, 5801.7099145042575, 5801.767929282823, 5809.448102430262, 29938.85030574855, 30789.846050769604, 30827.537586936214, 31135.37729245425, 31366.215844603837, 2127.680847872816, 2155.6874253233195, 2156.493224092337, 2157.611629906616, 2166.155199472207, 20283.594328113355, 20871.0, 20882.89558552213, 20898.686519702216, 20952.0, 2417.456072383717, 2487.452760392711, 2520.117958714435, 2527.292358139724, 2538.314655043128, 155261.0, 162011.0, 162115.1894240533, 162338.0, 162503.0, 14428.0, 15577.688446231012, 15579.610509737347, 15690.372385104696, 16131.516054518383, 24120.63819042716, 24338.148164814145, 24431.0, 24985.750142498706, 25047.62428563573, 10603.416812075257, 10616.575336986589, 10625.787484250426, 10782.0, 10863.893969834166, 9785.412875227508, 9827.606895724091, 9872.654457094111, 9894.55474503649, 9953.502324883872, 9654.75863103428, 9848.71966644346, 9883.456409897524, 10072.1366547189, 10231.539580718885, 2688.193541937411, 2699.8515081670303, 2732.5764506501523, 2794.4271424357958, 2829.4765468388005, 1056.8731752189785, 1066.7653116314398, 1073.9677809665723, 1074.2641290715885, 1078.1374900079904, 21639.0, 21872.0, 21881.781182187973, 21909.561808764054, 21956.780432195792, 1127.5827943660734, 1137.4483375562845, 1137.778133264022, 1148.615213903335, 1163.650904728578, 11855.525778968744, 12173.878261217451, 12225.298062220743, 12235.388230588434, 12292.569760058534, 619349.0, 629788.0, 658463.0, 661208.0, 665609.0, 145830.27084864507, 145863.0, 146887.0, 147141.0, 149377.0, 1323.483841301893, 1328.813966044774, 1359.5785306555, 1371.519968011208, 1373.8763511284033, 22868.542629147658, 23172.768272317735, 23297.650535242323, 23418.180363687872, 23523.529529408974, 68285.31714682988, 70292.29707702858, 70828.29171708217, 70882.0, 71152.64423677849, 85011.57494212489, 85287.0, 86426.0, 86440.0, 87010.5649471774, 15252.923735381251, 15787.131707756183, 15790.36838526446, 15795.21023948775, 15829.287682054566, 25400.74599254058, 25553.87223063947, 25621.0, 25755.197136200288, 25969.870150649127, 20332.17010469065, 20686.482837929172, 20939.685904711136, 21089.57820843544, 21104.0, 18284.177212025756, 18286.08569571543, 18525.72211416857, 18907.0, 19075.236990520225, 21556.353309400743, 21603.675944860526, 21731.674024889955, 21860.562788744453, 21945.231916882833, 15344.462943796914, 15517.612059698145, 15561.76657350118, 15618.219089045275, 15639.296231669374, 20729.481762956046, 20733.27433539819, 20770.48073798167, 20875.0, 20890.0], "value": 13003.789846470832, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1404.1364560795112, 1450.9274536273183, 1470.9411623535057, 1471.3526048538636, 1473.1382141447245, 15930.123843188634, 16237.83762162378, 16364.099974501398, 16510.091944943022, 16617.750733738972, 15663.0, 15881.285342159601, 15899.205039747996, 15904.204789760524, 15922.601934951632, 2589.443269697015, 2697.0829917827937, 2764.5853122031654, 2767.6955534891144, 2768.6816016158095, 2699.325168707823, 2736.5621500559914, 2737.931551711203, 2739.4384151248946, 2743.0, 2707.28257011892, 2713.72862713729, 2724.087430710704, 2725.0734750184934, 2725.7819374449996, 2562.3466016165853, 2573.9485210295784, 2584.9224523264334, 2594.6886373635098, 2595.260350800032, 2491.1405565080017, 2498.71264804548, 2517.509085728284, 2523.1421316752394, 2593.1831473085917, 15985.040897546185, 16105.516834494983, 16111.758323625156, 16131.516054518266, 16133.27400266979, 7826.530408175471, 8059.274665280153, 8059.597020148969, 8074.838503229961, 8089.150639182919, 5055.545000949932, 5057.974710126463, 5094.668846525001, 5211.140161873286, 5226.268322434862, 1922.5097600111883, 1922.6539222939866, 1930.5366711989022, 1965.1746266568075, 1994.182385222052, 28583.28541786451, 28618.14145575615, 28720.71279287201, 28839.0, 28878.42243155125, 6322.430981211713, 6363.809085727436, 6413.711382987777, 6513.674316284261, 6520.282768895418, 19235.0, 19278.614427711367, 19289.90355048216, 19338.806611933982, 19367.225310987404, 7724.420668449889, 7873.881891771628, 7886.72396466121, 7887.250711182429, 7890.289873911375, 6199.225096862892, 7064.434845212473, 7197.388222001084, 7262.854742905218, 7330.450216233804, 5182.4299327073995, 5280.683159010472, 5291.232771248147, 5297.576193904479, 5351.491608297206, 1483.7403454395437, 1487.9032862863878, 1495.452206965807, 1496.4089184771954, 1524.1388615432245, 921.9585118669676, 939.3659279985982, 941.4868896451451, 945.4516380499294, 951.9428834269966, 7997.120316765151, 8025.9598702006115, 8035.156308587631, 8087.919120808717, 8136.959315203386, 750.2160242546552, 751.2750196060828, 759.4304271796153, 759.5936174146805, 768.7271018788362, 4945.727984960789, 4951.356323677899, 4994.250862370601, 5461.508464238238, 6005.249343832021, 22788.43028924257, 23812.88093559521, 24049.7595024051, 24050.15824446136, 24090.759092409204, 22942.8852855738, 23314.0, 23686.0, 24261.39346516316, 24568.877155614464, 12433.0, 12686.746265074647, 12713.87286127127, 12736.872631273754, 12802.03984701151, 9281.67514137002, 9348.53257337144, 9428.62285508572, 9504.192143667866, 9616.855747163938, 20591.176352945713, 20828.47928801792, 20951.0, 21348.0, 21417.78582214158, 21025.264115755876, 21366.78633213648, 21461.141554337653, 21632.67550986768, 21781.782182177976, 12164.391780410768, 12604.369781511072, 12647.177933434297, 12855.421506032064, 13296.335183240994, 15061.246937653294, 15134.243287835785, 15134.470293539673, 15210.695786084438, 15216.391344346102, 11856.11079169083, 11941.0, 12023.21849079807, 12094.939525302669, 12103.394830258629, 11758.470868810753, 11796.88203117992, 11880.584179553674, 11993.34036627959, 12015.939920300343, 10466.16270698327, 10471.738206544896, 10719.517621706886, 10816.837747433638, 10824.67525974222, 8416.621252043551, 8524.914750852413, 8545.615447304763, 8591.0, 8614.44006139599, 7994.560299183368, 8027.076886157933, 8042.0, 8059.717909873127, 8202.589870506332], "value": 6930.206871988037, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [515.8117287190175, 517.6919732759012, 527.5331331771382, 531.9787208511659, 536.3001283325261, 6147.477464415519, 6168.920438923187, 6181.28915174755, 6207.131001659771, 6236.63221860195, 6088.786892458765, 6090.482309003729, 6100.206973093492, 6146.293176284728, 6172.135900973867, 4850.587700045483, 4855.732934688591, 4876.902696893206, 4877.463479017314, 4880.829170979016, 4681.9063618727605, 4751.691140075884, 4782.83260085897, 4784.736839473828, 4869.293952376903, 4681.0, 4737.123632128068, 4743.193657078305, 4796.280557916306, 4806.663533552653, 4723.763811809413, 4737.620990320766, 4743.881402964919, 4760.476347601761, 4790.640701947368, 4176.874693759192, 4277.786110694453, 4312.3531470279395, 4324.113556720865, 4336.934945975813, 5898.14476900847, 5942.97028514859, 5955.7915472958675, 5957.136215248808, 5966.343702192798, 5654.717264136818, 5721.885562288772, 5751.856203594902, 5756.7985120521, 5768.903908257417, 6543.1821022372205, 6608.0, 6617.162046013349, 6626.73493060277, 6635.834104147387, 4823.807047718087, 4848.9757551212015, 4861.781219845116, 4908.950910490885, 4913.115639184945, 6616.0, 6645.867082658319, 6747.414357625954, 6839.521233513656, 6900.723971041152, 4989.800407983713, 4999.75001249936, 5008.544104567836, 5042.218456139304, 5049.671771334852, 5128.7179205144075, 5143.562797162208, 5145.511176438307, 5158.0199762045095, 5165.638405311592, 5643.830685079454, 5664.575156863251, 5667.603267771216, 5752.712364381764, 5758.3665796762325, 6544.0, 6569.868602627921, 6572.638504882278, 6613.503987200979, 6617.602943823386, 1784.9196786144655, 1787.6514079754322, 1791.2029147029707, 1795.6678014567347, 1797.469746424808, 1195.229077245172, 1233.3216730798026, 1255.9623211303492, 1265.0954567484293, 1267.9175853569488, 6292.46514046302, 6293.496520278367, 6305.432511074026, 6312.305646378894, 6347.428731414195, 6740.696668649923, 6759.831004224934, 6773.322667733188, 6776.15298087739, 6783.626900520519, 6265.8120256392385, 6292.905606415908, 6296.401841825019, 6298.590591611531, 6314.179156709598, 3488.8430020648625, 3557.8932632021083, 3559.323728491578, 3587.94618080729, 3600.6939410149907, 6994.950757386433, 7052.541584796972, 7079.504434689522, 7099.538529995534, 7107.111611048619, 6363.150294072112, 6769.830754231184, 6887.210679674739, 6898.965505172542, 6936.549124306904, 6765.627890465973, 6928.263335982359, 6966.442684585322, 6975.093237879043, 7006.824829379204, 6546.149000630078, 6563.671816409065, 6585.949640970673, 6626.4367528760595, 6709.966450167718, 6557.377049180321, 6596.340365963365, 6635.767748128792, 6637.933620663732, 6653.63405012729, 6989.895151572832, 6994.7759142150935, 7032.1912980007955, 7056.470764692771, 7075.398591119812, 5053.393592768891, 5108.514691104339, 5111.718855462986, 5119.820806271762, 5122.7449274927885, 6516.837079073061, 6624.867502650017, 6699.296573859675, 6816.931830681629, 6845.5550389224545, 6549.672516374067, 6563.9343606563325, 6582.637954912526, 6583.111279977334, 6594.604323740591, 6582.868342633216, 6599.0202939119035, 6599.967000164968, 6600.405963463311, 6609.7771912196395, 6549.805815052011, 6554.967225163844, 6576.8355791105605, 6591.835204119935, 6595.736170553316, 6482.384173503509, 6497.675116244074, 6559.277899671582, 6585.176852893388, 6600.471962242913, 6293.811185664437, 6326.841828954313, 6386.616802991835, 6400.327965563549, 6425.164728585254], "value": 5093.631272154404, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [941.8401263760084, 944.9763755906101, 965.932384733069, 966.1497881863959, 985.4579981010445, 19781.901090494564, 20398.0, 20417.387478375655, 20442.89778551109, 22016.44958876029, 22430.887845560792, 22696.319110426713, 22729.54540909185, 22735.658965115537, 22742.65886011711, 1002.4486532407184, 1023.0996722883889, 1023.626376372626, 1027.4349107990613, 1028.7942411517727, 1041.1878734587035, 1068.4230515521647, 1083.9403832789194, 1094.4527736131934, 1100.4882729530766, 1140.4012893231038, 1140.948657310423, 1141.549088110196, 1142.3716955674347, 1142.857142857143, 1139.3164101539053, 1139.3505701750005, 1139.7378602921292, 1142.9657110286664, 1145.2441388683471, 836.477201748907, 836.9916300837035, 837.5937670229933, 839.49630221867, 839.8908141941508, 20760.37718868421, 21123.894380528, 21254.362369128798, 21915.561688766134, 22157.556848862932, 21537.56924861494, 21551.67672484914, 21566.676499852358, 21838.23566175176, 22006.44983875416, 16389.508314750576, 16655.750163747554, 16673.166341682987, 16842.326306947707, 16849.157542122844, 3889.086064774776, 3894.2990261752875, 3897.629725176104, 3898.4542164097047, 3916.902077448058, 149614.0, 149908.2504587481, 150315.0, 150905.0, 151911.0, 17044.14779261032, 17090.401835935932, 17178.31286748516, 17206.225719842638, 17366.739498907526, 34487.31025379529, 34700.13249668779, 34886.476702849475, 35065.824670876485, 35076.473852892224, 8310.8337833243, 8470.788230294293, 8634.740957771277, 8739.737807865775, 8821.029686734453, 4397.2085024695225, 4414.227510185705, 4453.777311134495, 4490.079533695584, 4496.595306422372, 5709.571782116358, 5795.710214489343, 5852.209951656557, 5903.203067585907, 5927.9703601481715, 1178.4107946026986, 1186.0630102219322, 1210.0622017935993, 1215.611004478576, 1219.0674134287278, 724.1708244060521, 746.3805041815281, 747.7270796159471, 751.0424209133398, 765.7970637780993, 13338.666533336744, 13510.86489135096, 13598.252096134807, 14017.0, 14375.137491750529, 715.2561336210387, 721.264310403396, 723.1683563901555, 725.9637018149072, 733.9449541284425, 6754.5947243165565, 7234.493585448968, 7246.96376518114, 7267.818304542323, 7273.0908636420445, 130603.0, 132640.3367983154, 135543.0, 140674.0, 141789.0, 115867.0, 120663.99999999824, 122325.0, 123228.0, 123485.0, 108898.08484266898, 110642.99999999838, 111171.44414278038, 112565.0, 113193.0, 12883.677908052, 13809.240491772647, 14023.80797632172, 14164.362603682654, 14199.787003194753, 49364.75317623389, 50071.0, 50829.745851270505, 51003.0, 51542.0, 84304.57847710722, 86282.0, 86777.0, 88120.55939720261, 88259.55870220608, 18879.811201887806, 18978.52553686169, 19260.0, 19412.514687132934, 19510.60978780445, 21439.142434302452, 21608.67586986228, 22631.434214144778, 22699.0, 25455.0, 22450.10199591998, 22903.88548057249, 23092.191773287854, 23618.763812361656, 24123.51752964966, 20481.795182048583, 21950.560988779816, 22214.888925555268, 22928.4267893304, 23162.0, 19298.4210473686, 19611.901940490778, 19656.312029078912, 19819.405417837486, 21441.89279053595, 12645.747085058063, 13156.276404797827, 13690.0, 13897.930510347787, 14903.0, 15475.922620386826, 16084.919575402047, 16427.67144657124, 16571.597118418, 17503.21235544429], "value": 10243.345246572419, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1458.0, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 107.0, 98.0, 110.0, 106.0, 106.0, 107.0, 100.0, 107.0, 108.0], "value": 105.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 113.0, 142.0, 159.0, 114.0, 144.0, 141.0, 115.0, 172.0, 125.0], "value": 136.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 163.0, 163.0, 161.0, 163.0, 164.0, 162.0, 163.0, 170.0, 169.0], "value": 164.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 73.0, 73.0, 118.0, 73.0, 75.0, 74.0, 92.0, 95.0, 75.0], "value": 82.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 78.0, 134.0, 79.0, 78.0, 79.0, 127.0, 78.0, 77.0, 124.0], "value": 93.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 114.0, 113.0, 116.0, 117.0, 114.0, 113.0, 114.0, 113.0, 113.0], "value": 114.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 148.0, 147.0, 147.0, 147.0, 147.0, 147.0, 148.0, 147.0, 148.0], "value": 147.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 95.0, 94.0, 93.0, 94.0, 102.0, 93.0, 95.0, 94.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [47.0, 47.0, 47.0, 47.0, 47.0, 47.0, 49.0, 48.0, 48.0, 48.0], "value": 47.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 55.0, 54.0, 54.0, 54.0, 54.0, 54.0, 55.0, 54.0, 55.0], "value": 54.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 73.0, 72.0, 73.0, 72.0, 74.0, 72.0, 72.0, 72.0, 71.0], "value": 72.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 117.0, 113.0, 119.0, 113.0, 116.0, 113.0, 114.0, 113.0, 156.0], "value": 118.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 162.0, 171.0, 165.0, 166.0, 164.0, 164.0, 162.0, 159.0], "value": 163.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 69.0, 60.0, 63.0, 62.0, 61.0, 59.0, 63.0, 60.0, 68.0], "value": 62.7, "unit": "score"}]}]} 11:41:04 INFO - Return code: 0 11:41:04 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:41:04 INFO - # TBPL SUCCESS # 11:41:04 INFO - Running post-action listener: _package_coverage_data 11:41:04 INFO - Running post-action listener: _resource_record_post_action 11:41:04 INFO - [mozharness: 2017-08-19 18:41:04.911159Z] Finished run-tests step (success) 11:41:04 INFO - Running post-run listener: _resource_record_post_run 11:41:04 INFO - Total resource usage - Wall time: 1187s; CPU: 13.0%; Read bytes: 4096; Write bytes: 431738880; Read time: 20; Write time: 237272 11:41:04 INFO - TinderboxPrint: CPU usage
13.1% 11:41:04 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 20 11:41:04 INFO - TinderboxPrint: I/O write bytes / time
431,738,880 / 237,272 11:41:04 INFO - TinderboxPrint: CPU idle
8,226.9 (86.9%) 11:41:04 INFO - TinderboxPrint: CPU user
1,188.8 (12.6%) 11:41:04 INFO - TinderboxPrint: Swap in / out
0 / 0 11:41:04 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 108363776; Read time: 0; Write time: 61892 11:41:04 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 11:41:05 INFO - run-tests - Wall time: 1169s; CPU: 13.0%; Read bytes: 0; Write bytes: 323375104; Read time: 0; Write time: 175380 11:41:05 INFO - Running post-run listener: _upload_blobber_files 11:41:05 INFO - Blob upload gear active. 11:41:05 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:41:05 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 11:41:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 11:41:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 11:41:05 INFO - (blobuploader) - INFO - Open directory for files ... 11:41:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:41:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:41:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:41:12 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:41:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:41:12 INFO - (blobuploader) - INFO - Done attempting. 11:41:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 11:41:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:41:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:41:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 11:41:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:41:13 INFO - (blobuploader) - INFO - Done attempting. 11:41:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 11:41:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:41:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:41:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 11:41:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:41:13 INFO - (blobuploader) - INFO - Done attempting. 11:41:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 11:41:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:41:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:41:14 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 11:41:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:41:14 INFO - (blobuploader) - INFO - Done attempting. 11:41:14 INFO - (blobuploader) - INFO - Iteration through files over. 11:41:14 INFO - Return code: 0 11:41:14 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:41:14 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:41:14 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/07efb8f074feb6e3b69fa3ed1d6b814d5d7df545f4ec8ae30399e7d25bb1e677b21a0caa7c47719e2b125456772e971f30c29f9080164415f9967ee28d67371a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bd9778269460a5c8a035f3e21bb4d3a85a61e0006cd965b3d285cbc98e65e6ed1661d2f3d200da0ecc2a7d07e7019bde67bb7fb312215421aca1e188d78a403e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e699a164bbad098a5f363c7269db149933fcf9c03a7cb5f64e12532fe9968c0871760e05607961381770842c8de34f9983ecc2bb9db28124bf5b2fc98d84df8e", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ccd596065816e1b65b88a6b0101c2c1561d2f9c42c11a0bbe213d12ceeb7188c5824ffbb352f0a1f3284bad8132a13e39ff528f6d2646dab69fee832d5862c15"} 11:41:14 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:41:14 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:41:14 INFO - Contents: 11:41:14 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/07efb8f074feb6e3b69fa3ed1d6b814d5d7df545f4ec8ae30399e7d25bb1e677b21a0caa7c47719e2b125456772e971f30c29f9080164415f9967ee28d67371a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bd9778269460a5c8a035f3e21bb4d3a85a61e0006cd965b3d285cbc98e65e6ed1661d2f3d200da0ecc2a7d07e7019bde67bb7fb312215421aca1e188d78a403e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e699a164bbad098a5f363c7269db149933fcf9c03a7cb5f64e12532fe9968c0871760e05607961381770842c8de34f9983ecc2bb9db28124bf5b2fc98d84df8e", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ccd596065816e1b65b88a6b0101c2c1561d2f9c42c11a0bbe213d12ceeb7188c5824ffbb352f0a1f3284bad8132a13e39ff528f6d2646dab69fee832d5862c15"} 11:41:14 INFO - Running post-run listener: copy_logs_to_upload_dir 11:41:14 INFO - Copying logs to upload dir... 11:41:14 INFO - mkdir: /builds/slave/test/build/upload/logs 11:41:14 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1251.647730 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 51 secs) (at 2017-08-19 11:41:13.636427) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-19 11:41:13.640120) ========= 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=199fb4c72b90437b990b419b000001c5-1503157798.40273-991027235 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/07efb8f074feb6e3b69fa3ed1d6b814d5d7df545f4ec8ae30399e7d25bb1e677b21a0caa7c47719e2b125456772e971f30c29f9080164415f9967ee28d67371a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bd9778269460a5c8a035f3e21bb4d3a85a61e0006cd965b3d285cbc98e65e6ed1661d2f3d200da0ecc2a7d07e7019bde67bb7fb312215421aca1e188d78a403e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e699a164bbad098a5f363c7269db149933fcf9c03a7cb5f64e12532fe9968c0871760e05607961381770842c8de34f9983ecc2bb9db28124bf5b2fc98d84df8e", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ccd596065816e1b65b88a6b0101c2c1561d2f9c42c11a0bbe213d12ceeb7188c5824ffbb352f0a1f3284bad8132a13e39ff528f6d2646dab69fee832d5862c15"} build_url:https://queue.taskcluster.net/v1/task/b8xBkx50Q2CXfFW1_WrhUg/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011434 build_url: 'https://queue.taskcluster.net/v1/task/b8xBkx50Q2CXfFW1_WrhUg/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/07efb8f074feb6e3b69fa3ed1d6b814d5d7df545f4ec8ae30399e7d25bb1e677b21a0caa7c47719e2b125456772e971f30c29f9080164415f9967ee28d67371a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bd9778269460a5c8a035f3e21bb4d3a85a61e0006cd965b3d285cbc98e65e6ed1661d2f3d200da0ecc2a7d07e7019bde67bb7fb312215421aca1e188d78a403e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e699a164bbad098a5f363c7269db149933fcf9c03a7cb5f64e12532fe9968c0871760e05607961381770842c8de34f9983ecc2bb9db28124bf5b2fc98d84df8e", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ccd596065816e1b65b88a6b0101c2c1561d2f9c42c11a0bbe213d12ceeb7188c5824ffbb352f0a1f3284bad8132a13e39ff528f6d2646dab69fee832d5862c15"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-19 11:41:13.666624) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-19 11:41:13.666939) ========= 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=199fb4c72b90437b990b419b000001c5-1503157798.40273-991027235 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004493 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-19 11:41:13.749469) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-19 11:41:13.749773) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-19 11:41:13.750032) ========= ========= Total master_lag: 0.16 =========