builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-080 starttime: 1503268756.55 results: success (0) revision: 0286df0f0eba0e81e2c628c332f90457c38ea926 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-08-20 15:39:16.547933) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-08-20 15:39:16.548437) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-20 15:39:16.548715) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-20 15:39:16.573154) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-20 15:39:16.573492) ========= 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=781b77c4c33858b1f599d705000001c1-1503268342.742509-78226362 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-08-20 15:39:17-- 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% 218M=0s 2017-08-20 15:39:17 (218 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.220800 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-20 15:39:16.809870) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-20 15:39:16.810198) ========= 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=781b77c4c33858b1f599d705000001c1-1503268342.742509-78226362 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014936 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-20 15:39:16.861869) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-08-20 15:39:16.862167) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 0286df0f0eba0e81e2c628c332f90457c38ea926 --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 0286df0f0eba0e81e2c628c332f90457c38ea926 --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=781b77c4c33858b1f599d705000001c1-1503268342.742509-78226362 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-08-20 15:39:17,533 truncating revision to first 12 chars 2017-08-20 15:39:17,533 Setting DEBUG logging. 2017-08-20 15:39:17,533 attempt 1/10 2017-08-20 15:39:17,533 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/0286df0f0eba?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-08-20 15:39:18,940 unpacking tar archive at: mozilla-central-0286df0f0eba/testing/mozharness/ program finished with exit code 0 elapsedTime=1.799124 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-08-20 15:39:18.681623) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-20 15:39:18.681939) ========= script_repo_revision: 0286df0f0eba0e81e2c628c332f90457c38ea926 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-20 15:39:18.682338) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-20 15:39:18.682603) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-20 15:39:18.694561) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 51 secs) (at 2017-08-20 15:39:18.694830) ========= /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=781b77c4c33858b1f599d705000001c1-1503268342.742509-78226362 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:39:19 INFO - MultiFileLogger online at 20170820 15:39:19 in /builds/slave/test 15:39:19 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 15:39:19 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:39:19 INFO - {'append_to_log': False, 15:39:19 INFO - 'base_work_dir': '/builds/slave/test', 15:39:19 INFO - 'blob_upload_branch': 'Firefox', 15:39:19 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:39:19 INFO - 'branch': 'Firefox', 15:39:19 INFO - 'buildbot_json_path': 'buildprops.json', 15:39:19 INFO - 'code_coverage': False, 15:39:19 INFO - 'config_files': ('talos/linux_config.py',), 15:39:19 INFO - 'default_actions': ('clobber', 15:39:19 INFO - 'read-buildbot-config', 15:39:19 INFO - 'download-and-extract', 15:39:19 INFO - 'populate-webroot', 15:39:19 INFO - 'create-virtualenv', 15:39:19 INFO - 'install', 15:39:19 INFO - 'setup-mitmproxy', 15:39:19 INFO - 'run-tests'), 15:39:19 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:39:19 INFO - 'disable_ccov_upload': False, 15:39:19 INFO - 'download_minidump_stackwalk': True, 15:39:19 INFO - 'download_symbols': 'ondemand', 15:39:19 INFO - 'enable_stylo': False, 15:39:19 INFO - 'enable_webrender': False, 15:39:19 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:39:19 INFO - 'tooltool.py': '/tools/tooltool.py', 15:39:19 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:39:19 INFO - '/tools/misc-python/virtualenv.py')}, 15:39:19 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:39:19 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:39:19 INFO - 'gecko_profile': False, 15:39:19 INFO - 'gecko_profile_interval': 0, 15:39:19 INFO - 'installer_path': 'installer.exe', 15:39:19 INFO - 'log_level': 'info', 15:39:19 INFO - 'log_name': 'talos', 15:39:19 INFO - 'log_to_console': True, 15:39:19 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:39:19 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:39:19 INFO - 'opt_config_files': (), 15:39:19 INFO - 'pip_index': False, 15:39:19 INFO - 'suite': 'dromaeojs-e10s', 15:39:19 INFO - 'system_bits': '32', 15:39:19 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:39:19 INFO - 'title': 'talos-linux64-ix-080', 15:39:19 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:39:19 INFO - 'use_talos_json': True, 15:39:19 INFO - 'verify': 'False', 15:39:19 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:39:19 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:39:19 INFO - 'work_dir': 'build'} 15:39:19 INFO - [mozharness: 2017-08-20 22:39:19.500982Z] Running clobber step. 15:39:19 INFO - Running pre-action listener: _resource_record_pre_action 15:39:19 INFO - Running main action method: clobber 15:39:19 INFO - rmtree: /builds/slave/test/build 15:39:19 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:39:21 INFO - Running post-action listener: _resource_record_post_action 15:39:21 INFO - [mozharness: 2017-08-20 22:39:21.032101Z] Finished clobber step (success) 15:39:21 INFO - [mozharness: 2017-08-20 22:39:21.032199Z] Running read-buildbot-config step. 15:39:21 INFO - Running pre-action listener: _resource_record_pre_action 15:39:21 INFO - Running main action method: read_buildbot_config 15:39:21 INFO - Using buildbot properties: 15:39:21 INFO - { 15:39:21 INFO - "project": "", 15:39:21 INFO - "product": "firefox", 15:39:21 INFO - "who": "archaeopteryx@coole-files.de", 15:39:21 INFO - "installer_path": "public/build/target.tar.bz2", 15:39:21 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 15:39:21 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 15:39:21 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 15:39:21 INFO - "stage_platform": "linux64-pgo", 15:39:21 INFO - "basedir": "/builds/slave/test", 15:39:21 INFO - "buildnumber": 120, 15:39:21 INFO - "platform": "ubuntu64_hw", 15:39:21 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 15:39:21 INFO - "slavebuilddir": "test", 15:39:21 INFO - "taskId": "WYy6gN4VQUiAf8J-ub2S3w", 15:39:21 INFO - "branch": "mozilla-central", 15:39:21 INFO - "script_repo_revision": "production", 15:39:21 INFO - "revision": "0286df0f0eba0e81e2c628c332f90457c38ea926", 15:39:21 INFO - "slavename": "talos-linux64-ix-080", 15:39:21 INFO - "repo_path": "mozilla-central" 15:39:21 INFO - } 15:39:21 INFO - Finding installer, test and symbols from parent task. 15:39:21 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WYy6gN4VQUiAf8J-ub2S3w'}, attempt #1 15:39:21 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WYy6gN4VQUiAf8J-ub2S3w'}, attempt #1 15:39:21 INFO - Task dependencies: VXxr4_LqSUqVGy4lHai7VQ 15:39:21 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/VXxr4_LqSUqVGy4lHai7VQ'}, attempt #1 15:39:22 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/VXxr4_LqSUqVGy4lHai7VQ/artifacts/public/build/target.tar.bz2 15:39:22 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/VXxr4_LqSUqVGy4lHai7VQ/artifacts/public/build/target.test_packages.json 15:39:22 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/VXxr4_LqSUqVGy4lHai7VQ/artifacts/public/build/target.crashreporter-symbols.zip 15:39:22 INFO - Running post-action listener: _resource_record_post_action 15:39:22 INFO - [mozharness: 2017-08-20 22:39:22.422586Z] Finished read-buildbot-config step (success) 15:39:22 INFO - [mozharness: 2017-08-20 22:39:22.422950Z] Running download-and-extract step. 15:39:22 INFO - Running pre-action listener: _resource_record_pre_action 15:39:22 INFO - Running main action method: download_and_extract 15:39:22 INFO - mkdir: /builds/slave/test/build/tests 15:39:22 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')]} 15:39:22 INFO - trying https://queue.taskcluster.net/v1/task/VXxr4_LqSUqVGy4lHai7VQ/artifacts/public/build/target.test_packages.json 15:39:22 INFO - Downloading https://queue.taskcluster.net/v1/task/VXxr4_LqSUqVGy4lHai7VQ/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 15:39:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/VXxr4_LqSUqVGy4lHai7VQ/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 15:39:23 INFO - Downloaded 989 bytes. 15:39:23 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 15:39:23 INFO - Using the following test package requirements: 15:39:23 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 15:39:23 INFO - u'common': [u'target.common.tests.zip'], 15:39:23 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 15:39:23 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 15:39:23 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 15:39:23 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 15:39:23 INFO - u'mozbase': [u'target.common.tests.zip'], 15:39:23 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 15:39:23 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 15:39:23 INFO - u'web-platform': [u'target.common.tests.zip', 15:39:23 INFO - u'target.web-platform.tests.tar.gz'], 15:39:23 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 15:39:23 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 15:39:23 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/VXxr4_LqSUqVGy4lHai7VQ/artifacts/public/build/target.common.tests.zip 15:39:23 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/VXxr4_LqSUqVGy4lHai7VQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 15:39:23 INFO - Fetch https://queue.taskcluster.net/v1/task/VXxr4_LqSUqVGy4lHai7VQ/artifacts/public/build/target.common.tests.zip into memory 15:39:24 INFO - Content-Length response header: 54619336 15:39:24 INFO - Bytes received: 54619336 15:39:35 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 15:39:35 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/VXxr4_LqSUqVGy4lHai7VQ/artifacts/public/build/target.common.tests.zip 15:39:35 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/VXxr4_LqSUqVGy4lHai7VQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 15:39:35 INFO - Fetch https://queue.taskcluster.net/v1/task/VXxr4_LqSUqVGy4lHai7VQ/artifacts/public/build/target.common.tests.zip into memory 15:39:36 INFO - Content-Length response header: 54619336 15:39:36 INFO - Bytes received: 54619336 15:39:48 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/VXxr4_LqSUqVGy4lHai7VQ/artifacts/public/build/target.talos.tests.zip 15:39:48 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/VXxr4_LqSUqVGy4lHai7VQ/artifacts/public/build/target.talos.tests.zip'}, attempt #1 15:39:48 INFO - Fetch https://queue.taskcluster.net/v1/task/VXxr4_LqSUqVGy4lHai7VQ/artifacts/public/build/target.talos.tests.zip into memory 15:39:49 INFO - Content-Length response header: 14496256 15:39:49 INFO - Bytes received: 14496256 15:39:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:39:49 INFO - trying https://queue.taskcluster.net/v1/task/VXxr4_LqSUqVGy4lHai7VQ/artifacts/public/build/target.tar.bz2 15:39:49 INFO - Downloading https://queue.taskcluster.net/v1/task/VXxr4_LqSUqVGy4lHai7VQ/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 15:39:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/VXxr4_LqSUqVGy4lHai7VQ/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 15:39:52 INFO - Downloaded 63181291 bytes. 15:39:52 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/VXxr4_LqSUqVGy4lHai7VQ/artifacts/public/build/target.tar.bz2 15:39:52 INFO - mkdir: /builds/slave/test/properties 15:39:52 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:39:52 INFO - Writing to file /builds/slave/test/properties/build_url 15:39:52 INFO - Contents: 15:39:52 INFO - build_url:https://queue.taskcluster.net/v1/task/VXxr4_LqSUqVGy4lHai7VQ/artifacts/public/build/target.tar.bz2 15:39:52 INFO - Running post-action listener: _resource_record_post_action 15:39:52 INFO - Running post-action listener: find_tests_for_verification 15:39:52 INFO - Running post-action listener: set_extra_try_arguments 15:39:52 INFO - [mozharness: 2017-08-20 22:39:52.048570Z] Finished download-and-extract step (success) 15:39:52 INFO - [mozharness: 2017-08-20 22:39:52.048667Z] Running populate-webroot step. 15:39:52 INFO - Running pre-action listener: _resource_record_pre_action 15:39:52 INFO - Running main action method: populate_webroot 15:39:52 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:39:52 INFO - 'chromez-stylo-e10s': {'talos_options': ['--stylo'], 15:39:52 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:39:52 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:39:52 INFO - 'dromaeojs-stylo-e10s': {'talos_options': ['--stylo'], 15:39:52 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:39:52 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 15:39:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:39:52 INFO - 'g1-stylo-e10s': {'pagesets_name': 'tp5n.zip', 15:39:52 INFO - 'talos_options': ['--stylo'], 15:39:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:39:52 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 15:39:52 INFO - 'tests': ['damp', 'tps']}, 15:39:52 INFO - 'g2-stylo-e10s': {'pagesets_name': 'tp5n.zip', 15:39:52 INFO - 'talos_options': ['--stylo'], 15:39:52 INFO - 'tests': ['damp', 'tps']}, 15:39:52 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:39:52 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 15:39:52 INFO - 'g4-stylo-e10s': {'talos_options': ['--stylo'], 15:39:52 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 15:39:52 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 15:39:52 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 15:39:52 INFO - 'g5-stylo-e10s': {'pagesets_name': 'tp5n.zip', 15:39:52 INFO - 'talos_options': ['--stylo'], 15:39:52 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 15:39:52 INFO - 'other-e10s': {'tests': ['a11yr', 15:39:52 INFO - 'ts_paint', 15:39:52 INFO - 'tpaint', 15:39:52 INFO - 'sessionrestore', 15:39:52 INFO - 'sessionrestore_many_windows', 15:39:52 INFO - 'sessionrestore_no_auto_restore', 15:39:52 INFO - 'tabpaint']}, 15:39:52 INFO - 'other-stylo-e10s': {'talos_options': ['--stylo'], 15:39:52 INFO - 'tests': ['a11yr', 15:39:52 INFO - 'ts_paint', 15:39:52 INFO - 'tpaint', 15:39:52 INFO - 'sessionrestore', 15:39:52 INFO - 'sessionrestore_many_windows', 15:39:52 INFO - 'sessionrestore_no_auto_restore', 15:39:52 INFO - 'tabpaint']}, 15:39:52 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 15:39:52 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 15:39:52 INFO - 'perf-reftest-singletons-stylo-e10s': {'talos_options': ['--stylo'], 15:39:52 INFO - 'tests': ['bloom_basic_singleton']}, 15:39:52 INFO - 'perf-reftest-stylo-e10s': {'talos_options': ['--stylo'], 15:39:52 INFO - 'tests': ['bloom_basic']}, 15:39:52 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:39:52 INFO - 'tsvgr_opacity', 15:39:52 INFO - 'tart', 15:39:52 INFO - 'tscrollx', 15:39:52 INFO - 'tsvg_static']}, 15:39:52 INFO - 'svgr-stylo-e10s': {'talos_options': ['--stylo'], 15:39:52 INFO - 'tests': ['tsvgx', 15:39:52 INFO - 'tsvgr_opacity', 15:39:52 INFO - 'tart', 15:39:52 INFO - 'tscrollx', 15:39:52 INFO - 'tsvg_static']}, 15:39:52 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 15:39:52 INFO - 'tp5o-stylo-e10s': {'pagesets_name': 'tp5n.zip', 15:39:52 INFO - 'talos_options': ['--stylo'], 15:39:52 INFO - 'tests': ['tp5o']}, 15:39:52 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 15:39:52 INFO - 'talos_options': ['--mitmproxy', 15:39:52 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 15:39:52 INFO - '--firstNonBlankPaint'], 15:39:52 INFO - 'tests': ['tp6_google', 15:39:52 INFO - 'tp6_youtube', 15:39:52 INFO - 'tp6_amazon', 15:39:52 INFO - 'tp6_facebook']}, 15:39:52 INFO - 'tp6-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 15:39:52 INFO - 'talos_options': ['--stylo', 15:39:52 INFO - '--mitmproxy', 15:39:52 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 15:39:52 INFO - '--firstNonBlankPaint'], 15:39:52 INFO - 'tests': ['tp6_google', 15:39:52 INFO - 'tp6_youtube', 15:39:52 INFO - 'tp6_amazon', 15:39:52 INFO - 'tp6_facebook']}, 15:39:52 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 15:39:52 INFO - 'talos_options': ['--stylo', 15:39:52 INFO - '--stylo-threads=1', 15:39:52 INFO - '--mitmproxy', 15:39:52 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 15:39:52 INFO - '--firstNonBlankPaint'], 15:39:52 INFO - 'tests': ['tp6_google', 15:39:52 INFO - 'tp6_youtube', 15:39:52 INFO - 'tp6_amazon', 15:39:52 INFO - 'tp6_facebook']}, 15:39:52 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 15:39:52 INFO - 'talos_options': ['--xperf_path', 15:39:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:39:52 INFO - 'tests': ['tp5n']}, 15:39:52 INFO - 'xperf-stylo-e10s': {'pagesets_name': 'tp5n.zip', 15:39:52 INFO - 'talos_options': ['--stylo', 15:39:52 INFO - '--xperf_path', 15:39:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:39:52 INFO - 'tests': ['tp5n']}}} 15:39:52 INFO - Running post-action listener: _resource_record_post_action 15:39:52 INFO - [mozharness: 2017-08-20 22:39:52.063023Z] Finished populate-webroot step (success) 15:39:52 INFO - [mozharness: 2017-08-20 22:39:52.063113Z] Running create-virtualenv step. 15:39:52 INFO - Running pre-action listener: _resource_record_pre_action 15:39:52 INFO - Running main action method: create_virtualenv 15:39:52 INFO - Creating virtualenv /builds/slave/test/build/venv 15:39:52 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 15:39:52 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:39:52 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 15:39:52 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:39:52 INFO - Using real prefix '/usr' 15:39:52 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:39:52 INFO - Installing distribute.............................................................................................................................................................................................done. 15:39:54 INFO - Installing pip.................done. 15:39:54 INFO - Return code: 0 15:39:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 15:39:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 15:39:54 INFO - Reading from file tmpfile_stdout 15:39:54 INFO - Output received: 15:39:54 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) 15:39:54 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:39: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')]} 15:39:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:39: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')]} 15:39:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:39:54 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 0x27661f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2931a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ad4f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ad2130>, '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 0x2ad3030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ad34c0>, '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': '781b77c4c33858b1f599d705000001c1-1503268342.742509-78226362', '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 15:39:54 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 15:39:54 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 15:39:54 INFO - Using env: {'DISPLAY': ':0', 15:39:54 INFO - 'HOME': '/home/cltbld', 15:39:54 INFO - 'LANG': 'en_US.UTF-8', 15:39:54 INFO - 'LANGUAGE': 'en_US:en', 15:39:54 INFO - 'LOGNAME': 'cltbld', 15:39:54 INFO - 'MAIL': '/var/mail/cltbld', 15:39:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:39:54 INFO - 'MOZ_NO_REMOTE': '1', 15:39:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:39:54 INFO - 'NO_EM_RESTART': '1', 15:39:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:39:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:39:54 INFO - 'PWD': '/builds/slave/test', 15:39:54 INFO - 'SHELL': '/bin/bash', 15:39:54 INFO - 'SHLVL': '1', 15:39:54 INFO - 'TERM': 'linux', 15:39:54 INFO - 'TMOUT': '86400', 15:39:54 INFO - 'USER': 'cltbld', 15:39:54 INFO - 'XDG_SESSION_COOKIE': '781b77c4c33858b1f599d705000001c1-1503268342.742509-78226362', 15:39:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:39:54 INFO - '_': '/tools/buildbot/bin/python'} 15:39:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:39:55 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 15:39:55 INFO - Cleaning up... 15:39:55 INFO - Return code: 0 15:39:55 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:39:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:39:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:39:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:39:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:39:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x27661f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2931a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ad4f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ad2130>, '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 0x2ad3030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ad34c0>, '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': '781b77c4c33858b1f599d705000001c1-1503268342.742509-78226362', '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 15:39:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 15:39:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 15:39:55 INFO - Using env: {'DISPLAY': ':0', 15:39:55 INFO - 'HOME': '/home/cltbld', 15:39:55 INFO - 'LANG': 'en_US.UTF-8', 15:39:55 INFO - 'LANGUAGE': 'en_US:en', 15:39:55 INFO - 'LOGNAME': 'cltbld', 15:39:55 INFO - 'MAIL': '/var/mail/cltbld', 15:39:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:39:55 INFO - 'MOZ_NO_REMOTE': '1', 15:39:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:39:55 INFO - 'NO_EM_RESTART': '1', 15:39:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:39:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:39:55 INFO - 'PWD': '/builds/slave/test', 15:39:55 INFO - 'SHELL': '/bin/bash', 15:39:55 INFO - 'SHLVL': '1', 15:39:55 INFO - 'TERM': 'linux', 15:39:55 INFO - 'TMOUT': '86400', 15:39:55 INFO - 'USER': 'cltbld', 15:39:55 INFO - 'XDG_SESSION_COOKIE': '781b77c4c33858b1f599d705000001c1-1503268342.742509-78226362', 15:39:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:39:55 INFO - '_': '/tools/buildbot/bin/python'} 15:39:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:39:55 INFO - Downloading/unpacking psutil>=3.1.1 15:39:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:39:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:39:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:39:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:39:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:39:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:39:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:39:56 INFO - Installing collected packages: psutil 15:39:56 INFO - Running setup.py install for psutil 15:39:56 INFO - building 'psutil._psutil_linux' extension 15:39:56 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 15:39:56 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 15:39:56 INFO - building 'psutil._psutil_posix' extension 15:39:56 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 15:39:56 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 15:39:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:39:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:39:56 INFO - Successfully installed psutil 15:39:56 INFO - Cleaning up... 15:39:57 INFO - Return code: 0 15:39:57 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:39:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:39:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:39:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:39:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:39:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27661f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2931a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ad4f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ad2130>, '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 0x2ad3030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ad34c0>, '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': '781b77c4c33858b1f599d705000001c1-1503268342.742509-78226362', '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 15:39:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 15:39:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 15:39:57 INFO - Using env: {'DISPLAY': ':0', 15:39:57 INFO - 'HOME': '/home/cltbld', 15:39:57 INFO - 'LANG': 'en_US.UTF-8', 15:39:57 INFO - 'LANGUAGE': 'en_US:en', 15:39:57 INFO - 'LOGNAME': 'cltbld', 15:39:57 INFO - 'MAIL': '/var/mail/cltbld', 15:39:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:39:57 INFO - 'MOZ_NO_REMOTE': '1', 15:39:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:39:57 INFO - 'NO_EM_RESTART': '1', 15:39:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:39:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:39:57 INFO - 'PWD': '/builds/slave/test', 15:39:57 INFO - 'SHELL': '/bin/bash', 15:39:57 INFO - 'SHLVL': '1', 15:39:57 INFO - 'TERM': 'linux', 15:39:57 INFO - 'TMOUT': '86400', 15:39:57 INFO - 'USER': 'cltbld', 15:39:57 INFO - 'XDG_SESSION_COOKIE': '781b77c4c33858b1f599d705000001c1-1503268342.742509-78226362', 15:39:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:39:57 INFO - '_': '/tools/buildbot/bin/python'} 15:39:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:39:57 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:39:57 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 15:39:57 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 15:39:57 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 15:39:57 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 15:39:58 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:39:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:39:58 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:39:58 INFO - Installing collected packages: mozsystemmonitor 15:39:58 INFO - Running setup.py install for mozsystemmonitor 15:39:58 INFO - Successfully installed mozsystemmonitor 15:39:58 INFO - Cleaning up... 15:39:58 INFO - Return code: 0 15:39:58 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:39:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:39:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:39:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:39:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:39:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x27661f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2931a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ad4f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ad2130>, '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 0x2ad3030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ad34c0>, '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': '781b77c4c33858b1f599d705000001c1-1503268342.742509-78226362', '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 15:39:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 15:39:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 15:39:58 INFO - Using env: {'DISPLAY': ':0', 15:39:58 INFO - 'HOME': '/home/cltbld', 15:39:58 INFO - 'LANG': 'en_US.UTF-8', 15:39:58 INFO - 'LANGUAGE': 'en_US:en', 15:39:58 INFO - 'LOGNAME': 'cltbld', 15:39:58 INFO - 'MAIL': '/var/mail/cltbld', 15:39:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:39:58 INFO - 'MOZ_NO_REMOTE': '1', 15:39:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:39:58 INFO - 'NO_EM_RESTART': '1', 15:39:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:39:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:39:58 INFO - 'PWD': '/builds/slave/test', 15:39:58 INFO - 'SHELL': '/bin/bash', 15:39:58 INFO - 'SHLVL': '1', 15:39:58 INFO - 'TERM': 'linux', 15:39:58 INFO - 'TMOUT': '86400', 15:39:58 INFO - 'USER': 'cltbld', 15:39:58 INFO - 'XDG_SESSION_COOKIE': '781b77c4c33858b1f599d705000001c1-1503268342.742509-78226362', 15:39:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:39:58 INFO - '_': '/tools/buildbot/bin/python'} 15:39:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:39:58 INFO - Downloading/unpacking jsonschema==2.5.1 15:39:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:39:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:39:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:39:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:39:59 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:39:59 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:39:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:39:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:39:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:39:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:39:59 INFO - Downloading functools32-3.2.3-2.tar.gz 15:39:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:40:00 INFO - warning: no files found matching '*.txt' 15:40:00 INFO - no previously-included directories found matching 'build' 15:40:00 INFO - no previously-included directories found matching 'dist' 15:40:00 INFO - no previously-included directories found matching '.git*' 15:40:00 INFO - Installing collected packages: jsonschema, functools32 15:40:00 INFO - Running setup.py install for functools32 15:40:00 INFO - warning: no files found matching '*.txt' 15:40:00 INFO - no previously-included directories found matching 'build' 15:40:00 INFO - no previously-included directories found matching 'dist' 15:40:00 INFO - no previously-included directories found matching '.git*' 15:40:00 INFO - Successfully installed jsonschema functools32 15:40:00 INFO - Cleaning up... 15:40:00 INFO - Return code: 0 15:40:00 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 15:40: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')]} 15:40:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:40: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')]} 15:40:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:40: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', '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 0x27661f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2931a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ad4f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ad2130>, '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 0x2ad3030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ad34c0>, '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': '781b77c4c33858b1f599d705000001c1-1503268342.742509-78226362', '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 15:40: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 15:40: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 functools32==3.2.3-2 15:40:00 INFO - Using env: {'DISPLAY': ':0', 15:40:00 INFO - 'HOME': '/home/cltbld', 15:40:00 INFO - 'LANG': 'en_US.UTF-8', 15:40:00 INFO - 'LANGUAGE': 'en_US:en', 15:40:00 INFO - 'LOGNAME': 'cltbld', 15:40:00 INFO - 'MAIL': '/var/mail/cltbld', 15:40:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:40:00 INFO - 'MOZ_NO_REMOTE': '1', 15:40:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:40:00 INFO - 'NO_EM_RESTART': '1', 15:40:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:40:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:40:00 INFO - 'PWD': '/builds/slave/test', 15:40:00 INFO - 'SHELL': '/bin/bash', 15:40:00 INFO - 'SHLVL': '1', 15:40:00 INFO - 'TERM': 'linux', 15:40:00 INFO - 'TMOUT': '86400', 15:40:00 INFO - 'USER': 'cltbld', 15:40:00 INFO - 'XDG_SESSION_COOKIE': '781b77c4c33858b1f599d705000001c1-1503268342.742509-78226362', 15:40:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:40:00 INFO - '_': '/tools/buildbot/bin/python'} 15:40:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:40:00 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 15:40:00 INFO - Cleaning up... 15:40:00 INFO - Return code: 0 15:40:00 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:40: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')]} 15:40:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:40: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')]} 15:40:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:40: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', '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 0x27661f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2931a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ad4f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ad2130>, '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 0x2ad3030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ad34c0>, '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': '781b77c4c33858b1f599d705000001c1-1503268342.742509-78226362', '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 15:40: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 15:40: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 blobuploader==1.2.4 15:40:00 INFO - Using env: {'DISPLAY': ':0', 15:40:00 INFO - 'HOME': '/home/cltbld', 15:40:00 INFO - 'LANG': 'en_US.UTF-8', 15:40:00 INFO - 'LANGUAGE': 'en_US:en', 15:40:00 INFO - 'LOGNAME': 'cltbld', 15:40:00 INFO - 'MAIL': '/var/mail/cltbld', 15:40:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:40:00 INFO - 'MOZ_NO_REMOTE': '1', 15:40:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:40:00 INFO - 'NO_EM_RESTART': '1', 15:40:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:40:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:40:00 INFO - 'PWD': '/builds/slave/test', 15:40:00 INFO - 'SHELL': '/bin/bash', 15:40:00 INFO - 'SHLVL': '1', 15:40:00 INFO - 'TERM': 'linux', 15:40:00 INFO - 'TMOUT': '86400', 15:40:00 INFO - 'USER': 'cltbld', 15:40:00 INFO - 'XDG_SESSION_COOKIE': '781b77c4c33858b1f599d705000001c1-1503268342.742509-78226362', 15:40:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:40:00 INFO - '_': '/tools/buildbot/bin/python'} 15:40:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:40:00 INFO - Downloading/unpacking blobuploader==1.2.4 15:40: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 15:40: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 15:40: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 15:40: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 15:40:01 INFO - Downloading blobuploader-1.2.4.tar.gz 15:40:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:40:01 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:40:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:40:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:40:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:40:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:40:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:40:02 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:40: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 15:40: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 15:40: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 15:40: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 15:40:02 INFO - Downloading docopt-0.6.1.tar.gz 15:40:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:40:02 INFO - Installing collected packages: blobuploader, requests, docopt 15:40:02 INFO - Running setup.py install for blobuploader 15:40:02 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:40:02 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:40:02 INFO - Running setup.py install for requests 15:40:02 INFO - Running setup.py install for docopt 15:40:02 INFO - Successfully installed blobuploader requests docopt 15:40:02 INFO - Cleaning up... 15:40:02 INFO - Return code: 0 15:40:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:40: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')]} 15:40:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:40: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')]} 15:40:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:40:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27661f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2931a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ad4f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ad2130>, '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 0x2ad3030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ad34c0>, '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': '781b77c4c33858b1f599d705000001c1-1503268342.742509-78226362', '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 15:40:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 15:40:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:40:02 INFO - Using env: {'DISPLAY': ':0', 15:40:02 INFO - 'HOME': '/home/cltbld', 15:40:02 INFO - 'LANG': 'en_US.UTF-8', 15:40:02 INFO - 'LANGUAGE': 'en_US:en', 15:40:02 INFO - 'LOGNAME': 'cltbld', 15:40:02 INFO - 'MAIL': '/var/mail/cltbld', 15:40:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:40:02 INFO - 'MOZ_NO_REMOTE': '1', 15:40:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:40:02 INFO - 'NO_EM_RESTART': '1', 15:40:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:40:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:40:02 INFO - 'PWD': '/builds/slave/test', 15:40:02 INFO - 'SHELL': '/bin/bash', 15:40:02 INFO - 'SHLVL': '1', 15:40:02 INFO - 'TERM': 'linux', 15:40:02 INFO - 'TMOUT': '86400', 15:40:02 INFO - 'USER': 'cltbld', 15:40:02 INFO - 'XDG_SESSION_COOKIE': '781b77c4c33858b1f599d705000001c1-1503268342.742509-78226362', 15:40:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:40:02 INFO - '_': '/tools/buildbot/bin/python'} 15:40:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:40:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:40:03 INFO - Running setup.py (path:/tmp/pip-Zf_eKU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:40:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:40:03 INFO - Running setup.py (path:/tmp/pip-D5N0hq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:40:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:40:03 INFO - Running setup.py (path:/tmp/pip-jDQyJI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:40:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:40:03 INFO - Running setup.py (path:/tmp/pip-MzXd7O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:40:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:40:03 INFO - Running setup.py (path:/tmp/pip-bcn79y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:40:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:40:03 INFO - Running setup.py (path:/tmp/pip-_kvTpq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:40:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:40:03 INFO - Running setup.py (path:/tmp/pip-W100Jt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:40:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:40:03 INFO - Running setup.py (path:/tmp/pip-ZCKBRh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:40:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:40:03 INFO - Running setup.py (path:/tmp/pip-2PLg8t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:40:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:40:03 INFO - Running setup.py (path:/tmp/pip-W4egOi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:40:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:40:03 INFO - Running setup.py (path:/tmp/pip-xdZakL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:40:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:40:03 INFO - Running setup.py (path:/tmp/pip-DTZmBV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:40:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:40:04 INFO - Running setup.py (path:/tmp/pip-2WHUqy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:40:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:40:04 INFO - Running setup.py (path:/tmp/pip-7rqlQR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:40:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:40:04 INFO - Running setup.py (path:/tmp/pip-UpIDA5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:40:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:40:04 INFO - Running setup.py (path:/tmp/pip-PAUT75-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:40:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:40:04 INFO - Running setup.py (path:/tmp/pip-9nnqBN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:40:04 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:40:04 INFO - Running setup.py install for manifestparser 15:40:04 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:40:04 INFO - Running setup.py install for mozcrash 15:40:04 INFO - Running setup.py install for mozdebug 15:40:04 INFO - Running setup.py install for mozdevice 15:40:04 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:40:04 INFO - Running setup.py install for mozfile 15:40:04 INFO - Running setup.py install for mozhttpd 15:40:04 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:40:04 INFO - Running setup.py install for mozinfo 15:40:05 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:40:05 INFO - Running setup.py install for mozInstall 15:40:05 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:40:05 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:40:05 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:40:05 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:40:05 INFO - Running setup.py install for mozleak 15:40:05 INFO - Running setup.py install for mozlog 15:40:05 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:40:05 INFO - Running setup.py install for moznetwork 15:40:05 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:40:05 INFO - Running setup.py install for mozprocess 15:40:05 INFO - Running setup.py install for mozprofile 15:40:05 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:40:05 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:40:05 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:40:05 INFO - Running setup.py install for mozrunner 15:40:05 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:40:05 INFO - Running setup.py install for mozscreenshot 15:40:05 INFO - Running setup.py install for moztest 15:40:06 INFO - Running setup.py install for mozversion 15:40:06 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:40:06 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:40:06 INFO - Cleaning up... 15:40:06 INFO - Return code: 0 15:40:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:40:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:40:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:40:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:40:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:40:06 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 0x27661f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2931a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ad4f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ad2130>, '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 0x2ad3030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ad34c0>, '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': '781b77c4c33858b1f599d705000001c1-1503268342.742509-78226362', '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 15:40:06 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 15:40:06 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 15:40:06 INFO - Using env: {'DISPLAY': ':0', 15:40:06 INFO - 'HOME': '/home/cltbld', 15:40:06 INFO - 'LANG': 'en_US.UTF-8', 15:40:06 INFO - 'LANGUAGE': 'en_US:en', 15:40:06 INFO - 'LOGNAME': 'cltbld', 15:40:06 INFO - 'MAIL': '/var/mail/cltbld', 15:40:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:40:06 INFO - 'MOZ_NO_REMOTE': '1', 15:40:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:40:06 INFO - 'NO_EM_RESTART': '1', 15:40:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:40:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:40:06 INFO - 'PWD': '/builds/slave/test', 15:40:06 INFO - 'SHELL': '/bin/bash', 15:40:06 INFO - 'SHLVL': '1', 15:40:06 INFO - 'TERM': 'linux', 15:40:06 INFO - 'TMOUT': '86400', 15:40:06 INFO - 'USER': 'cltbld', 15:40:06 INFO - 'XDG_SESSION_COOKIE': '781b77c4c33858b1f599d705000001c1-1503268342.742509-78226362', 15:40:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:40:06 INFO - '_': '/tools/buildbot/bin/python'} 15:40:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:40:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:40:06 INFO - Running setup.py (path:/tmp/pip-rnABLH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:40:06 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)) 15:40:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:40:06 INFO - Running setup.py (path:/tmp/pip-1_gKSe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:40:06 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)) 15:40:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:40:06 INFO - Running setup.py (path:/tmp/pip-HcgFMB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:40:06 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)) 15:40:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:40:06 INFO - Running setup.py (path:/tmp/pip-9NJHRS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:40:06 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)) 15:40:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:40:06 INFO - Running setup.py (path:/tmp/pip-9NwO_h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:40:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 15:40:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:40:06 INFO - Running setup.py (path:/tmp/pip-Wq5D6y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:40:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 15:40:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:40:06 INFO - Running setup.py (path:/tmp/pip-_iL9UJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:40:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.10 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 15:40:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:40:06 INFO - Running setup.py (path:/tmp/pip-1x5sBr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:40:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.13 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 15:40:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:40:06 INFO - Running setup.py (path:/tmp/pip-joY2Mz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:40:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 15:40:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:40:07 INFO - Running setup.py (path:/tmp/pip-VOkLY5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:40:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.5 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:40:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:40:07 INFO - Running setup.py (path:/tmp/pip-d41LeD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:40:07 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)) 15:40:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:40:07 INFO - Running setup.py (path:/tmp/pip-X69NbH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:40:07 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)) 15:40:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:40:07 INFO - Running setup.py (path:/tmp/pip-ChtFf6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:40:07 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)) 15:40:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:40:07 INFO - Running setup.py (path:/tmp/pip-UWP8hZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:40:07 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)) 15:40:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:40:07 INFO - Running setup.py (path:/tmp/pip-WzEmj8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:40:07 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)) 15:40:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:40:07 INFO - Running setup.py (path:/tmp/pip-8TbXiX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:40:07 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)) 15:40:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:40:07 INFO - Running setup.py (path:/tmp/pip-NuMklQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:40:07 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)) 15:40:07 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)) 15:40:07 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)) 15:40:07 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)) 15:40:07 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)) 15:40:07 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)) 15:40:07 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)) 15:40:07 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:40: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 15:40: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 15:40: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 15:40: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 15:40:08 INFO - Downloading blessings-1.6.tar.gz 15:40:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:40:08 INFO - Installing collected packages: blessings 15:40:08 INFO - Running setup.py install for blessings 15:40:08 INFO - Successfully installed blessings 15:40:08 INFO - Cleaning up... 15:40:09 INFO - Return code: 0 15:40:09 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:40:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:40:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:40:09 INFO - Reading from file tmpfile_stdout 15:40:09 INFO - Current package versions: 15:40:09 INFO - argparse == 1.2.1 15:40:09 INFO - blessings == 1.6 15:40:09 INFO - blobuploader == 1.2.4 15:40:09 INFO - docopt == 0.6.1 15:40:09 INFO - functools32 == 3.2.3-2 15:40:09 INFO - jsonschema == 2.5.1 15:40:09 INFO - manifestparser == 1.1 15:40:09 INFO - mozInstall == 1.13 15:40:09 INFO - mozcrash == 1.0 15:40:09 INFO - mozdebug == 0.1 15:40:09 INFO - mozdevice == 0.51 15:40:09 INFO - mozfile == 1.2 15:40:09 INFO - mozhttpd == 0.7 15:40:09 INFO - mozinfo == 0.10 15:40:09 INFO - mozleak == 0.1 15:40:09 INFO - mozlog == 3.5 15:40:09 INFO - moznetwork == 0.27 15:40:09 INFO - mozprocess == 0.25 15:40:09 INFO - mozprofile == 0.28 15:40:09 INFO - mozrunner == 6.13 15:40:09 INFO - mozscreenshot == 0.1 15:40:09 INFO - mozsystemmonitor == 0.3 15:40:09 INFO - moztest == 0.8 15:40:09 INFO - mozversion == 1.4 15:40:09 INFO - psutil == 3.1.1 15:40:09 INFO - requests == 1.2.3 15:40:09 INFO - wsgiref == 0.1.2 15:40:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:40:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:40:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:40:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:40:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:40:09 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 0x27661f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2931a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ad4f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ad2130>, '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 0x2ad3030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ad34c0>, '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': '781b77c4c33858b1f599d705000001c1-1503268342.742509-78226362', '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 15:40:09 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 15:40:09 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 15:40:09 INFO - Using env: {'DISPLAY': ':0', 15:40:09 INFO - 'HOME': '/home/cltbld', 15:40:09 INFO - 'LANG': 'en_US.UTF-8', 15:40:09 INFO - 'LANGUAGE': 'en_US:en', 15:40:09 INFO - 'LOGNAME': 'cltbld', 15:40:09 INFO - 'MAIL': '/var/mail/cltbld', 15:40:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:40:09 INFO - 'MOZ_NO_REMOTE': '1', 15:40:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:40:09 INFO - 'NO_EM_RESTART': '1', 15:40:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:40:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:40:09 INFO - 'PWD': '/builds/slave/test', 15:40:09 INFO - 'SHELL': '/bin/bash', 15:40:09 INFO - 'SHLVL': '1', 15:40:09 INFO - 'TERM': 'linux', 15:40:09 INFO - 'TMOUT': '86400', 15:40:09 INFO - 'USER': 'cltbld', 15:40:09 INFO - 'XDG_SESSION_COOKIE': '781b77c4c33858b1f599d705000001c1-1503268342.742509-78226362', 15:40:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:40:09 INFO - '_': '/tools/buildbot/bin/python'} 15:40:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:40:09 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)) 15:40:09 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)) 15:40:09 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)) 15:40:09 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)) 15:40:09 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)) 15:40:09 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)) 15:40:09 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)) 15:40:09 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)) 15:40:09 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)) 15:40:09 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 15:40:09 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 15:40:09 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 15:40:09 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 15:40:09 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 15:40:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 15:40:10 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 15:40:10 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 15:40:10 INFO - Installing collected packages: simplejson 15:40:10 INFO - Running setup.py install for simplejson 15:40:10 INFO - building 'simplejson._speedups' extension 15:40:10 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c simplejson/_speedups.c -o build/temp.linux-x86_64-2.7/simplejson/_speedups.o 15:40:11 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/simplejson/_speedups.o -o build/lib.linux-x86_64-2.7/simplejson/_speedups.so 15:40:11 INFO - Successfully installed simplejson 15:40:11 INFO - Cleaning up... 15:40:11 INFO - Return code: 0 15:40:11 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:40: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')]} 15:40:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:40: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')]} 15:40:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:40:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27661f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2931a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ad4f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ad2130>, '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 0x2ad3030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ad34c0>, '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': '781b77c4c33858b1f599d705000001c1-1503268342.742509-78226362', '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 15:40:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 15:40:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 15:40:11 INFO - Using env: {'DISPLAY': ':0', 15:40:11 INFO - 'HOME': '/home/cltbld', 15:40:11 INFO - 'LANG': 'en_US.UTF-8', 15:40:11 INFO - 'LANGUAGE': 'en_US:en', 15:40:11 INFO - 'LOGNAME': 'cltbld', 15:40:11 INFO - 'MAIL': '/var/mail/cltbld', 15:40:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:40:11 INFO - 'MOZ_NO_REMOTE': '1', 15:40:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:40:11 INFO - 'NO_EM_RESTART': '1', 15:40:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:40:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:40:11 INFO - 'PWD': '/builds/slave/test', 15:40:11 INFO - 'SHELL': '/bin/bash', 15:40:11 INFO - 'SHLVL': '1', 15:40:11 INFO - 'TERM': 'linux', 15:40:11 INFO - 'TMOUT': '86400', 15:40:11 INFO - 'USER': 'cltbld', 15:40:11 INFO - 'XDG_SESSION_COOKIE': '781b77c4c33858b1f599d705000001c1-1503268342.742509-78226362', 15:40:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:40:11 INFO - '_': '/tools/buildbot/bin/python'} 15:40:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:40:11 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:40:11 INFO - Cleaning up... 15:40:11 INFO - Return code: 0 15:40:11 INFO - Running post-action listener: _resource_record_post_action 15:40:11 INFO - Running post-action listener: _start_resource_monitoring 15:40:11 INFO - Starting resource monitoring. 15:40:11 INFO - [mozharness: 2017-08-20 22:40:11.924115Z] Finished create-virtualenv step (success) 15:40:11 INFO - [mozharness: 2017-08-20 22:40:11.924627Z] Running install step. 15:40:11 INFO - Running pre-action listener: _resource_record_pre_action 15:40:11 INFO - Running main action method: install 15:40:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:40:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:40:12 INFO - Reading from file tmpfile_stdout 15:40:12 INFO - Detecting whether we're running mozinstall >=1.0... 15:40:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:40:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:40:12 INFO - Reading from file tmpfile_stdout 15:40:12 INFO - Output received: 15:40:12 INFO - Usage: mozinstall [options] installer 15:40:12 INFO - Options: 15:40:12 INFO - -h, --help show this help message and exit 15:40:12 INFO - -d DEST, --destination=DEST 15:40:12 INFO - Directory to install application into. [default: 15:40:12 INFO - "/builds/slave/test"] 15:40:12 INFO - --app=APP Application being installed. [default: firefox] 15:40:12 INFO - mkdir: /builds/slave/test/build/application 15:40:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 15:40:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 15:40:30 INFO - Reading from file tmpfile_stdout 15:40:30 INFO - Output received: 15:40:30 INFO - /builds/slave/test/build/application/firefox/firefox 15:40:30 INFO - Running post-action listener: _resource_record_post_action 15:40:30 INFO - [mozharness: 2017-08-20 22:40:30.145826Z] Finished install step (success) 15:40:30 INFO - [mozharness: 2017-08-20 22:40:30.145975Z] Running setup-mitmproxy step. 15:40:30 INFO - Running pre-action listener: _resource_record_pre_action 15:40:30 INFO - Running main action method: setup_mitmproxy 15:40:30 INFO - Skipping: mitmproxy is not required 15:40:30 INFO - Running post-action listener: _resource_record_post_action 15:40:30 INFO - [mozharness: 2017-08-20 22:40:30.146534Z] Finished setup-mitmproxy step (success) 15:40:30 INFO - [mozharness: 2017-08-20 22:40:30.146778Z] Running run-tests step. 15:40:30 INFO - Running pre-action listener: _resource_record_pre_action 15:40:30 INFO - Running pre-action listener: _set_gcov_prefix 15:40:30 INFO - Running main action method: run_tests 15:40:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:40:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:40:30 INFO - Python 2.7.3 15:40:30 INFO - Return code: 0 15:40:30 INFO - grabbing minidump binary from tooltool 15:40:30 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')]} 15:40:30 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 0x2ad2130>, '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 0x2ad3030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ad34c0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:40:30 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 15:40:30 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 15:40:30 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 15:40:30 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:40:30 INFO - Return code: 0 15:40:30 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:40:30 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:40:30 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:40:30 INFO - ENV: RUST_BACKTRACE is now full 15:40:30 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:40:30 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:40:30 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/VXxr4_LqSUqVGy4lHai7VQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-080', '--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 15:40:30 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/VXxr4_LqSUqVGy4lHai7VQ/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-080 --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 15:40:30 INFO - Using env: {'DISPLAY': ':0', 15:40:30 INFO - 'HOME': '/home/cltbld', 15:40:30 INFO - 'LANG': 'en_US.UTF-8', 15:40:30 INFO - 'LANGUAGE': 'en_US:en', 15:40:30 INFO - 'LOGNAME': 'cltbld', 15:40:30 INFO - 'MAIL': '/var/mail/cltbld', 15:40:30 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:40:30 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:40:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:40:30 INFO - 'MOZ_NO_REMOTE': '1', 15:40:30 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:40:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:40:30 INFO - 'NO_EM_RESTART': '1', 15:40:30 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:40:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:40:30 INFO - 'PWD': '/builds/slave/test', 15:40:30 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:40:30 INFO - 'RUST_BACKTRACE': 'full', 15:40:30 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 15:40:30 INFO - 'SHELL': '/bin/bash', 15:40:30 INFO - 'SHLVL': '1', 15:40:30 INFO - 'TERM': 'linux', 15:40:30 INFO - 'TMOUT': '86400', 15:40:30 INFO - 'USER': 'cltbld', 15:40:30 INFO - 'XDG_SESSION_COOKIE': '781b77c4c33858b1f599d705000001c1-1503268342.742509-78226362', 15:40:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:40:30 INFO - '_': '/tools/buildbot/bin/python'} 15:40:30 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/VXxr4_LqSUqVGy4lHai7VQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-080', '--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 15:40:30 INFO - mozversion application_buildid: 20170820212203 15:40:30 INFO - mozversion application_changeset: 0286df0f0eba0e81e2c628c332f90457c38ea926 15:40:30 INFO - mozversion application_display_name: Nightly 15:40:30 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:40:30 INFO - mozversion application_name: Firefox 15:40:30 INFO - mozversion application_remotingname: firefox 15:40:30 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 15:40:30 INFO - mozversion application_vendor: Mozilla 15:40:30 INFO - mozversion application_version: 57.0a1 15:40:30 INFO - mozversion platform_buildid: 20170820212203 15:40:30 INFO - mozversion platform_changeset: 0286df0f0eba0e81e2c628c332f90457c38ea926 15:40:30 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 15:40:30 INFO - mozversion platform_version: 57.0a1 15:40:30 INFO - using testdate: 1503268830 15:40:30 INFO - actual date: 1503268830 15:40:30 INFO - starting webserver on 'localhost:33969' 15:40:30 INFO - SUITE-START | Running 2 tests 15:40:30 INFO - TEST-START | dromaeo_css 15:40:30 INFO - Initialising browser for dromaeo_css test... 15:40:30 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:33969/getInfo.html -profile /tmp/tmpbwbydP/profile 15:40:30 INFO - TEST-INFO | started process 16413 (/builds/slave/test/build/application/firefox/firefox http://localhost:33969/getInfo.html) 15:40:36 INFO - TEST-INFO | 16413: exit 0 15:40:36 INFO - Browser initialized. 15:40:36 INFO - Running cycle 1/1 for dromaeo_css test... 15:40:36 INFO - TEST-INFO | started process 16588 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbwbydP/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 15:40:37 INFO - PID 16588 | 15:40:37 INFO - PID 16588 | (/builds/slave/test/build/application/firefox/firefox:16638): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 15:40:37 INFO - PID 16588 | 15:40:38 INFO - PID 16588 | 15:40:38 INFO - PID 16588 | (/builds/slave/test/build/application/firefox/firefox:16691): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 15:40:38 INFO - PID 16588 | 15:40:38 INFO - PID 16588 | __metrics Screen width/height:1600/1200 15:40:38 INFO - PID 16588 | colorDepth:24 15:40:38 INFO - PID 16588 | Browser inner width/height: 1024/768 15:40:38 INFO - PID 16588 | __metrics 15:40:48 INFO - PID 16588 | RSS: Main: 165195776 15:40:48 INFO - PID 16588 | 15:43:45 INFO - PID 16588 | Cycle 1(1): loaded http://localhost:33969/tests/dromaeo/cssquery-dojo.html (next: http://localhost:33969/tests/dromaeo/cssquery-ext.html) 15:43:47 INFO - PID 16588 | RSS: Main: 170102784 15:43:47 INFO - PID 16588 | 15:46:48 INFO - PID 16588 | Cycle 1(1): loaded http://localhost:33969/tests/dromaeo/cssquery-ext.html (next: http://localhost:33969/tests/dromaeo/cssquery-jquery.html) 15:46:49 INFO - PID 16588 | RSS: Main: 167206912 15:46:49 INFO - PID 16588 | 15:49:50 INFO - PID 16588 | Cycle 1(1): loaded http://localhost:33969/tests/dromaeo/cssquery-jquery.html (next: http://localhost:33969/tests/dromaeo/cssquery-mootools.html) 15:49:51 INFO - PID 16588 | RSS: Main: 169017344 15:49:51 INFO - PID 16588 | 15:52:52 INFO - PID 16588 | Cycle 1(1): loaded http://localhost:33969/tests/dromaeo/cssquery-mootools.html (next: http://localhost:33969/tests/dromaeo/cssquery-prototype.html) 15:52:53 INFO - PID 16588 | RSS: Main: 167333888 15:52:53 INFO - PID 16588 | 15:55:56 INFO - PID 16588 | Cycle 1(1): loaded http://localhost:33969/tests/dromaeo/cssquery-prototype.html (next: http://localhost:33969/tests/dromaeo/cssquery-yui.html) 15:55:57 INFO - PID 16588 | RSS: Main: 171696128 15:55:57 INFO - PID 16588 | 15:58:59 INFO - PID 16588 | Cycle 1(1): loaded http://localhost:33969/tests/dromaeo/cssquery-yui.html (next: http://localhost:33969/tests/dromaeo/cssquery-dojo.html) 15:58:59 INFO - PID 16588 | RSS: Main: 171241472 15:58:59 INFO - PID 16588 | 15:58:59 INFO - PID 16588 | __start_tp_report 15:58:59 INFO - PID 16588 | _x_x_mozilla_page_load 15:58:59 INFO - PID 16588 | _x_x_mozilla_page_load_details 15:58:59 INFO - PID 16588 | |i|pagename|runs| 15:58:59 INFO - PID 16588 | |0;dojo.html;3374.8481318340673;3527.4532447470633;3548.6273941236154;3552.46712993051;3573.7141028717706;6158.6920653967345;6166.814995550135;6240.843978900524;6254.343293954137;6285.905711414327;6133.1413602095745;6196.752129914798;6197.535184861143;6199.566030377875;6213.751449942009;5480.671159730429;5567.053600887839;5568.610197286202;5586.972065139689;5605.327360716719;5408.432114627966;5458.4541545845295;5525.585581081415;5530.446955304457;5621.662700237978;5410.161424979135;5466.808661696821;5488.506034456878;5492.450754924515;5515.117581187011;5530.5299049580835;5541.418151094117;5549.889002219973;5618.9604923088955;5622.044252477048;5431.34823821144;5471.890562188773;5487.725613719298;5508.3114610673665;5573.498385145316;6189.721462534197;6203.689815509251;6218.315985241665;6232.844178895564;6238.376162383771;6730.32696730323;6751.864962700768;6821.488388370892;6825.965870170618;6842.7605033823575;6717.56335838169;6791.3548212919695;6793.082933803923;6798.694058767367;6833.829154271133;6388.488920886318;6396.136521569575;6397.136386587844;6400.871982560369;6407.359264073602;6965.442764578822;6969.6515174241085;6979.965100174467;7079.469039822034;7081.150261968597;6541.084248205255;6668.566543174678;6706.061151438803;6775.695093720795;6802.863942721118;6710.496712746563;6759.864802703918;6801.5238933274195;6808.931910680929;6829.351211634887;6737;6741.460683145337;6809.591424514545;6827.180738311435;6829.624370659562;6662.933370666328;6749.865002700017;6755.4257888080065;6844.965775171192;6850.006749021364;4870.9269360959615;4872.4640289568115;4900.191468407673;4903.754812259373;4909.729964851967;4339.132173565299;4368.4102646143;4385.232584297799;4390.3414487827085;4424.60178583929;6391.872162556723;6409;6477.319881412478;6477.6437295948235;6485.4487368573255;6530.8040758777315;6667.366600172976;6732.259451460335;6741.52809303344;6801.9319806801295;6488.545801793829;6517.608943463408;6521.673916304166;6523.3150519194805;6550.967245163743;5473.808416705396;5532.6680399176175;5533.972330138404;5548.91676624851;5574.526165275915;7137.286271372925;7179.31796479344;7218.67515961783;7250.854982900312;7253.274672532704;6628.8674226515195;6750.594964302158;6760.18877734675;6834.111565496453;6840.794776156723;7184.568925864465;7258.056452661121;7260.745873894389;7263.128424589083;7270.527415718173;6699.363560461748;6723.798286051427;6724.697388617622;6734.4949128816515;6798.116244888331;6735.090762746966;6797.286284940208;6868.484863635347;6942.236354000955;6953.33943275388;6590.077389165424;6676.6661666917435;6697.7655782047395;6704.597724136567;6709.4632429404555;6496.317886621837;6650.966745166436;6674.132362793;6679.298673639198;6682.498812588978;6596.5052621052655;6597.439217666552;6608.933910660832;6677.165354330708;6682;6504.317046710027;6513.088167656437;6579.572327798678;6581.14445122131;6585.736570537317;6397.424231819158;6404.743810247538;6412.166418365583;6421.133147025279;6468.6442245676935 15:58:59 INFO - PID 16588 | |1;ext.html;890.2032680750729;893.1071581212326;919.5310391700233;952.3143336797513;953.7663272498239;40758.184836303255;41933.16133677325;42025.57974420255;42306;42338.7883060585;43656.56343436565;44016.55983440165;44084.11831763363;44135;44137;7578.469507134489;7742.458027938046;7748.845023099535;7749.728759493419;7751.069871615414;7535.397168226528;7616.695332186706;7627.389808815282;7633.885491717629;7636.160022397532;7643.46495745298;7659.923400765977;7661.387089032864;7668.769936901902;7671.731489397872;7599.582022988733;7621.885671714928;7654.923450765505;7670.846583068307;7682.500637458603;7513.2862378074;7579.54522728638;7585.089789225328;7586.279303466162;7591.2029236929875;39852.800735996134;40121.59878401208;40145;40170.39744403836;40195.598044019476;3415.8975230743117;3456.948145777815;3457.533233013536;3457.8098204598737;3458.481227815848;31298.21754456134;31373.84313078443;31392.21519462009;31440;31440.685593144004;5119.897602047976;5133.153029750124;5155.74221288934;5181.5854731621375;5190.221466779975;190687;192244;192580;194127;210803.9459802722;51145;51256;51267.23099153516;51320;51332.23001654978;52506.47493525016;52748.20877686838;52754;52803.47196528062;52912.20631690528;16429.91785041067;16561.6687666246;16561.66876662484;16573.83426165723;16772.412965546147;13723.245221512712;13760.380782864795;13762.65593360174;13770.31148442594;13799.655008624864;13382.397792099378;13394.263315517544;13406.396712147976;13440;13519.932400337935;5264.078786212397;5275.63070585063;5316.973415132899;5317.654352467077;5339.946600533945;1061.0662616897082;1076.262760009396;1082.9404382759024;1089.7548051688307;1092.781548573335;23535.17626883051;23749.762502374757;24118;24214.757852421604;24381;1157.386585109893;1182.5033485935928;1186.3475088701352;1189.821526770974;1199.7409197349375;12433.067519936041;12702.936485317514;12709.491620335082;12791.872081279254;12854.550090746967;247331;249019;249297;249571;251201;53789.46210537844;53991;54009.189862152096;54010.18984715232;54280.72859635676;1511.833698293187;1521.0873475914584;1533.4632878492662;1555.066959824119;1561.718890599703;23817.285481435585;29227.70772292335;29278;29368.118956431343;30156.69843301539;52200.738996304775;52351.73824130855;52358.47641523536;52480.21279680732;52614.473855260956;216582;216679;216963;216998;217676;33227.83386083054;34352.62589496392;34430;35425.64574354327;35630.28739425249;46524.53475465202;46938;47411.28883066826;47769.52230477651;47885.28172077491;34474.482882756274;34916.82541587276;34918.30163396768;35067.47398789071;35332.82333588316;34309.65690343164;34515.654843451244;34525.65474345224;34571.82714086514;34903.650963491054;39819.20361592694;39931.60068399279;40166.598334016286;40257.19485610213;40363.19273614453;33315;33622;33726.83136584301;33917.66082339145;34351;24584.385390365384;26335.473290534464;26426.867865660548;26615.733842661324;26644.333891652863 15:58:59 INFO - PID 16588 | |2;jquery.html;529.4229290073819;552.8313864271396;560.2045095963731;574.6753084507255;591.4085914085914;22537.77462225377;23360.299191024274;23406.0637574497;23434.29697109085;23870.5225895482;26195.47609047818;26725.86637066817;26842.060527881527;26914.327141821464;26960.730392696067;6124.938750612492;6238.8440288992915;6250.374962503736;6253.1870856788555;6257.280412752523;6004.939950600482;6248.468880145193;6260.937390626081;6270.529710271725;6272.435480806726;6226.315105338409;6233.158523599302;6233.189685340899;6234.345393733661;6237.750489980395;6194.9070763938125;6221.657808820536;6222.502199824025;6223.190985171944;6224.284207316171;5762.394948530386;5767.567432442584;5779.9422005779825;5789.623674461147;5794.913076303858;30650.54024189639;31685.366292674247;31896;31932.521012184836;32429.837850810596;2170.1319472211085;2223.2552095048018;2233.028632544832;2233.7207849018873;2248.3704562722464;19626;20702;20706.896465517726;20746.377608671763;20798.688019679717;2431.756824317572;2490.4023034471597;2505.949881002388;2510.083819405904;2514.924552263435;157954;165615;165644;165677;166210;14938.908552802617;15468.071915685096;15670.294836732375;15707.450239241572;15970.680586388207;23884.164054258017;23922.162724304566;23926.88036559841;23989.640155397683;23992.76007239905;10201.74495637615;10379.377237365783;10488.31825931312;10804.945975270231;11112.499937502831;9316.301277404222;9475.715728528156;9522.952385238168;9651;9766.267529935283;9152.542372881462;9857.260705447121;9977.80044399108;10051.346662467062;10135.949320253352;2711.8372897626205;2813.324802047494;2817.4505971335802;2818.943621127566;2872.8132671376293;1013.9087482126497;1033.0702367868978;1037.1754455207977;1043.8068957242933;1048.8007278617038;22023.449413764785;22027.229046983277;22137.889310553343;22169.556608867733;22260.777392226195;1119.9440027998567;1120.7142178744368;1124.2692250037542;1125.4372813593204;1137.1641843245209;11999.700007499709;12054.758904821854;12168.330741809108;12168.783121687937;12208.145429820004;564445;573895;586006;590599;601051;130475;135559;135666;135720;136195;1109.5062697099875;1247.089624574066;1265.9810102848464;1279.174932168746;1284.531146131674;23195.53608927846;23219.419514512272;23323.183688570818;23424.06303747831;23461;59931.40068599258;60876.391236087075;61346;62494.68752656208;63217.68391158015;73659.63170184115;77024;77465;77747;77870.61064694867;13163.341832908125;13597.728045439233;14223.573292801233;14646.926765366105;15417.69164616679;24346.75653243445;24361;24405.26784196477;24466.266012019667;24757.009719611015;18537.35119270819;18702.906485467487;18981.71527427062;19010.714839277698;19012.144453499903;17167.914160429118;17168.22742976594;17823.554411139306;18007.639847203245;18055;19092.8090719091;19137.617247655246;19211.32760353381;19318.517037073623;20494.590108198052;14152.150870947364;14153.929230353782;14177.858221418066;14214.644633884236;14348.49780257686;20206.19175232974;20539.28112516055;20550.794492054887;20745.792542074385;20749.68875466839 15:58:59 INFO - PID 16588 | |3;mootools.html;1444.913305201688;1530.1278271385315;1544.9691006179876;1553.8579144328924;1556.3696702835352;15507.68984620307;16128.112953787537;16168.757468637965;16232.918835405835;16407.91796041021;16663.83336166638;16963.406280780175;16969.91515042426;16992.150392480387;17043.659126817456;2667.186508115024;2719.2250208690525;2719.7688196503223;2719.864006799652;2720.469508445854;2513.5098655762135;2556.2586849813533;2613.2290974162665;2702.4459985702883;2711.024031348713;2635.815492915487;2667.773239274664;2681.048227879104;2687.905923292685;2696.042904768808;2621.1612284069106;2622.986885065572;2637.709851916288;2638.1689767723105;2667.653205083346;2572.511222867649;2610.073423934514;2621.777148942342;2652.2308530526125;2654.190471906068;16281.348746050144;16397.91801040999;16402.179891005522;16410.015399076092;16417.753733694004;8225.670973161066;8492.447990880573;8502.574871256413;8510.319174466027;8510.914890851074;5007.32401125847;5268.473152684739;5334.07973129673;5350.5987050971335;5372.355317361902;1799.3072667023291;1805.8013618501955;1826.9086545672662;1852.2128095559333;1865.5429419792101;28819.27951801201;29005.70994290051;29035.56446653302;29177.70822291771;29206.415871682446;6964.616946067914;7463.253674632493;7486.588237646873;7713.074431068196;7837.373010159174;19192.13635386411;19277.51806204828;19425.125869335912;19452.416427507196;19466.221351145796;8251.793705157419;8384.455010424424;8384.958075209584;8481.915180848237;8484.957575212084;7668.233176682399;7728.304452599293;7741.7677469676;7746.0704715433385;7773.883391749128;5203.687778733288;5478.835634930959;5482.835514934558;5485.396606373296;5489.835304940858;1400.1249219237977;1414.929253537319;1492.082369342868;1502.4290769507518;1507.5778781941074;861.586438509519;879.9208071273616;891.8305521950808;895.1317222294364;903.2187158108189;8438.873416898752;8882.245009174163;8919.509426981449;8964.955175224213;9035.954820225857;1003.6537394598852;1049.5644307612408;1056.2447849787438;1063.1654151491043;1091.1161958813386;4537.228671125917;5382.650127741685;5655.236543066633;5764.933487304862;5870.236869206976;24011.879940600185;24381.756182437948;24414.633780493306;24839.5032099357;24887.62668559973;22991.310260692208;23391.88304058469;23740.406489837547;24110.276691699277;24130.276091717278;12362;12565.183263088053;12693.048021398617;12869.163504372185;12872.806907896389;8636.913630863612;9151.496667683341;9160.450372977642;9226.861597075915;9303.534823258946;20508.692369614768;20648.48378790542;20662.58674826465;20666.689999649716;21131.04910279072;21130.683039754724;21308.57382852365;21563.568728625025;21586.136554537643;22180.112795488;13252;13316.733665326832;13603.455861765418;13604.86395136036;13614.659633509242;13497.122687025312;14859.108453492825;15127.16800575979;15151.393944242107;15178.77231841501;10326.793464130526;11594.130440216848;11694;11868.465919033491;11901.345426001653;11374.43127843621;11502.252353596989;11649.708757281136;11701.239419437708;11881;10443.477826108512;10543.94728026355;10575.947120264349;10589.258751887293;10591.629292974709;8005.439619226831;8040.3969702273735;8089.312408445348;8111.472754270953;8264.958675206586;8124.63439145228;8216.507009579444;8224.177582241968;8268.131846156068;8334.708285209988 15:58:59 INFO - PID 16588 | |4;prototype.html;505.24465923444455;506.64915286878954;528.2657106621796;533.4265664410759;537.806389699708;6048.425399587043;6085.908711369333;6101.847453813657;6111.388861113886;6113.480354169896;6008.879822403549;6076.605020673653;6110.938890611093;6117.602355846867;6151.692415379235;4817.108834865544;4820.783064762094;4827.8310259140935;4844.224924012159;4869.269609558559;4551.407007547348;4627.930581041287;4760.071786001731;4800.399950006249;4811.67678888305;4621.399218101642;4628.606568441686;4635.953640463603;4667;4688.32019357193;4635.327877457749;4648.48866624671;4656.650751193657;4670.206064968964;4699.825043739065;4109.198706252282;4211.831526738927;4234.513031001444;4245.363195520666;4259.70182087254;5761.884762304772;5796;5839.970800146015;5871.266091738533;5896.675682837442;5442.755076021588;5518.779248830082;5549.334079910436;5606.915896261559;5652.74562644682;6396.680165991728;6450.322716114834;6502.544821862424;6511.38141876521;6512.641804700739;4802.735849528274;4816.157172494834;4835.081334546425;4871.82948596801;4884.389451318585;6548.607083575001;6672;6705.865882682319;6718.260991290954;6763.932360676379;4938.950610493921;4964.404271487445;4989.451160372429;5005;5021.297018417425;5020.013092210129;5039.395272567315;5053.46938571452;5055;5069.847904562869;5565.387807341189;5580.414056524007;5584;5616.5787565932715;5619.8876022480135;6497.545171838021;6518.413342799076;6564.606123632598;6586.473082153416;6587.484878477977;1711.9400820971207;1731.9134043298036;1734.2369357482667;1753.614204874951;1758.3757765993143;1132.7338075552238;1194.2834299420451;1204.9939750301369;1213.550986135118;1225.822255772908;6171.13604095427;6204.689765511706;6222.875542489125;6231.283402408691;6288.308286088527;6528.934710652928;6557.770478033246;6590.90113648286;6599.769008084694;6640.169978752656;6184.165137706442;6218.968905155536;6300.243970723451;6306.653134077578;6334.796388686135;3470.9413628843445;3503.684668379858;3512.877049303262;3533.381658209803;3557.8043207623828;7013.824654383579;7015.824604384829;7022.789316320519;7098.574085554883;7102.573845569179;6739.359760822714;6792.728290868409;6799.456043516507;6858.794236172923;6893.75871844493;6944.375006249462;7013.754518591825;7072.858542829012;7082.433405327562;7133.536320139175;6552.57408268461;6581;6643.202815661958;6663.533552651268;6695.330466953265;6668.566543174678;6670.733170673313;6698.5980841149685;6722.361375669304;6729.125213722381;6355.269144048493;6999.545029573062;7005.159380874327;7019.403350715246;7038.718451261892;4890.584300334512;4893.290472881484;4911.533404326583;4917.680350777188;4924.803007879645;6347.7318470350265;6485.837854053686;6533.705983230861;6629.4696424284975;6784.932150678627;6335.208098987627;6387.201599800025;6417.8716425672155;6467.838304042437;6472.805815825533;6367.363263673596;6397.680115994275;6430.453411460078;6473.514486413444;6486.740530378732;6391.808245752635;6395.840103997437;6451.580647257913;6511.79531786621;6550.47596192313;6471.676416179266;6476.740930362733;6544.3782840630065;6546.410823025951;6602.1747281589805;6367.840803979752;6377.58545694547;6388.776392826228;6410.679466026773;6415.230172379344 15:58:59 INFO - PID 16588 | |5;yui.html;942.0466836467674;950.6720181537368;980.85287206919;980.9944806573261;990.3414229537356;17325.22036508357;17417;17454.127293635316;17594.999999999967;21967.670484942737;20720.27479038234;22547.436314092116;22687.432814179654;22723.886380568114;22876.19933302335;1057.5928267616946;1085.6580177244143;1089.3028461784463;1089.3572792052687;1089.6785448292774;998.4907697074472;1077.8975997280286;1091.2743025887814;1092.7541303206754;1093.191038631411;1128.740389710367;1132.3602164776917;1133.880942501038;1135.5514571744156;1136.33524388233;1126.8591426071741;1126.8704099028635;1128.4527004402858;1129.3844854554288;1131.519104380639;828.159418190537;828.2338836576143;830.6635812495888;830.7507747675734;831.243568352796;17997.1001449927;18005.369812056517;18108.547286317815;19327.613447730968;21359.786402135935;22050.779492205194;22060.669089963663;22222.88888555547;22652.773472265395;22666.88666556673;15589.454369097028;15944.123073230967;16100.114493702842;16100.19499025044;16619.252133654016;3884.3202439573242;3913.745606535566;3914.099757055893;3914.706397020206;3915.5692873784146;146182;149851.25074374667;150736;151927;153771;16455.917720411322;16466.259018344204;17076.402325918534;17081;17082.829171708374;33362.49956250658;33765.987020389424;33980.830095849364;33987.15032124217;34093.14767130841;9039.909600903908;9187;9191.63233470667;9201.263898888074;9223.907760922304;4359.716618419792;4396.890077748082;4422.29243321067;4425.645948324126;4430.224710675683;5784.59507834456;5871.324797648325;5916.763329466859;5922.2597175353085;5936.910946335808;1035.4667346316653;1076.4510099849133;1086.3699054548342;1086.8206745886998;1090.1605763562013;652.5106170372221;664.35225654986;678.1997243253008;686.7630667419733;693.7225109956058;12101.939490302491;12637.557685480964;12702.936485317514;13005.934970325088;13156.144850584873;742.0427648333589;745.6905384265469;748.5620911766568;750.9586972716553;759.4342215049824;5615.578831587647;5656.208130861683;5820.82537523875;5861.5603829712945;5938.910916336258;121566;128208;131535;133812;135481.3225933864;118116.40941795237;119622.40188799174;119814;120966.39516802359;121537.39231303787;99572.50213748885;100036.99999999854;100409.49795250977;101055.49472252592;102204.48897755463;13789.172649641054;14081.859181408465;14094.859051409765;14121.576352709435;14137.363818628392;50836.74581627068;51072.744636276584;51414.42927853667;51544.48455515547;52330.47669523256;66899;67565.66217168883;67662;86598;86637;18555.536111597317;18829.811701883355;18883.527911802314;19033.524161895508;19853.503662407977;21025.158993640696;21182;21193.36419907405;21341.573168536852;23409.648855266845;19978.20087196496;21468.355949321547;21802.563948721254;21952.670709939044;22186;17366.739498907275;17681.11594420248;18111.63776724432;18263.54341141482;18482.445526634223;19483.61032779365;19935.60128797445;19993.500162496053;20164;20335.389938301876;13528.39122239482;14696.265186740835;14745.410183592536;14826.777598335817;15132.394704211709;13643.522476713268;15343.846561534689;15691.686166276382;15700.979436336602;16288.755668664742 15:58:59 INFO - PID 16588 | __end_tp_report 15:58:59 INFO - PID 16588 | __start_cc_report 15:58:59 INFO - PID 16588 | _x_x_mozilla_cycle_collect,340 15:58:59 INFO - PID 16588 | __end_cc_report 15:58:59 INFO - PID 16588 | __startTimestamp1503269939288__endTimestamp 15:58:59 INFO - PID 16588 | 15:58:59 INFO - PID 16588 | ------- Summary: start ------- 15:58:59 INFO - PID 16588 | Number of tests: 6 15:58:59 INFO - PID 16588 | 15:58:59 INFO - PID 16588 | [#0] dojo.html Cycles:165 Average:6242.18 Median:6530.80 stddev:819.02 (12.5%) stddev-sans-first:790.04 15:58:59 INFO - PID 16588 | Values: 3374.8 3527.5 3548.6 3552.5 3573.7 6158.7 6166.8 6240.8 6254.3 6285.9 6133.1 6196.8 6197.5 6199.6 6213.8 5480.7 5567.1 5568.6 5587.0 5605.3 5408.4 5458.5 5525.6 5530.4 5621.7 5410.2 5466.8 5488.5 5492.5 5515.1 5530.5 5541.4 5549.9 5619.0 5622.0 5431.3 5471.9 5487.7 5508.3 5573.5 6189.7 6203.7 6218.3 6232.8 6238.4 6730.3 6751.9 6821.5 6826.0 6842.8 6717.6 6791.4 6793.1 6798.7 6833.8 6388.5 6396.1 6397.1 6400.9 6407.4 6965.4 6969.7 6980.0 7079.5 7081.2 6541.1 6668.6 6706.1 6775.7 6802.9 6710.5 6759.9 6801.5 6808.9 6829.4 6737.0 6741.5 6809.6 6827.2 6829.6 6662.9 6749.9 6755.4 6845.0 6850.0 4870.9 4872.5 4900.2 4903.8 4909.7 4339.1 4368.4 4385.2 4390.3 4424.6 6391.9 6409.0 6477.3 6477.6 6485.4 6530.8 6667.4 6732.3 6741.5 6801.9 6488.5 6517.6 6521.7 6523.3 6551.0 5473.8 5532.7 5534.0 5548.9 5574.5 7137.3 7179.3 7218.7 7250.9 7253.3 6628.9 6750.6 6760.2 6834.1 6840.8 7184.6 7258.1 7260.7 7263.1 7270.5 6699.4 6723.8 6724.7 6734.5 6798.1 6735.1 6797.3 6868.5 6942.2 6953.3 6590.1 6676.7 6697.8 6704.6 6709.5 6496.3 6651.0 6674.1 6679.3 6682.5 6596.5 6597.4 6608.9 6677.2 6682.0 6504.3 6513.1 6579.6 6581.1 6585.7 6397.4 6404.7 6412.2 6421.1 6468.6 15:58:59 INFO - PID 16588 | 15:58:59 INFO - PID 16588 | [#1] ext.html Cycles:180 Average:40201.55 Median:34992.89 stddev:57593.17 (164.6%) stddev-sans-first:57679.09 15:58:59 INFO - PID 16588 | Values: 890.2 893.1 919.5 952.3 953.8 40758.2 41933.2 42025.6 42306.0 42338.8 43656.6 44016.6 44084.1 44135.0 44137.0 7578.5 7742.5 7748.8 7749.7 7751.1 7535.4 7616.7 7627.4 7633.9 7636.2 7643.5 7659.9 7661.4 7668.8 7671.7 7599.6 7621.9 7654.9 7670.8 7682.5 7513.3 7579.5 7585.1 7586.3 7591.2 39852.8 40121.6 40145.0 40170.4 40195.6 3415.9 3456.9 3457.5 3457.8 3458.5 31298.2 31373.8 31392.2 31440.0 31440.7 5119.9 5133.2 5155.7 5181.6 5190.2 190687.0 192244.0 192580.0 194127.0 210803.9 51145.0 51256.0 51267.2 51320.0 51332.2 52506.5 52748.2 52754.0 52803.5 52912.2 16429.9 16561.7 16561.7 16573.8 16772.4 13723.2 13760.4 13762.7 13770.3 13799.7 13382.4 13394.3 13406.4 13440.0 13519.9 5264.1 5275.6 5317.0 5317.7 5339.9 1061.1 1076.3 1082.9 1089.8 1092.8 23535.2 23749.8 24118.0 24214.8 24381.0 1157.4 1182.5 1186.3 1189.8 1199.7 12433.1 12702.9 12709.5 12791.9 12854.6 247331.0 249019.0 249297.0 249571.0 251201.0 53789.5 53991.0 54009.2 54010.2 54280.7 1511.8 1521.1 1533.5 1555.1 1561.7 23817.3 29227.7 29278.0 29368.1 30156.7 52200.7 52351.7 52358.5 52480.2 52614.5 216582.0 216679.0 216963.0 216998.0 217676.0 33227.8 34352.6 34430.0 35425.6 35630.3 46524.5 46938.0 47411.3 47769.5 47885.3 34474.5 34916.8 34918.3 35067.5 35332.8 34309.7 34515.7 34525.7 34571.8 34903.7 39819.2 39931.6 40166.6 40257.2 40363.2 33315.0 33622.0 33726.8 33917.7 34351.0 24584.4 26335.5 26426.9 26615.7 26644.3 15:58:59 INFO - PID 16588 | 15:58:59 INFO - PID 16588 | [#2] jquery.html Cycles:180 Average:39481.34 Median:23341.74 stddev:98402.49 (421.6%) stddev-sans-first:98635.07 15:58:59 INFO - PID 16588 | Values: 529.4 552.8 560.2 574.7 591.4 22537.8 23360.3 23406.1 23434.3 23870.5 26195.5 26725.9 26842.1 26914.3 26960.7 6124.9 6238.8 6250.4 6253.2 6257.3 6004.9 6248.5 6260.9 6270.5 6272.4 6226.3 6233.2 6233.2 6234.3 6237.8 6194.9 6221.7 6222.5 6223.2 6224.3 5762.4 5767.6 5779.9 5789.6 5794.9 30650.5 31685.4 31896.0 31932.5 32429.8 2170.1 2223.3 2233.0 2233.7 2248.4 19626.0 20702.0 20706.9 20746.4 20798.7 2431.8 2490.4 2505.9 2510.1 2514.9 157954.0 165615.0 165644.0 165677.0 166210.0 14938.9 15468.1 15670.3 15707.5 15970.7 23884.2 23922.2 23926.9 23989.6 23992.8 10201.7 10379.4 10488.3 10804.9 11112.5 9316.3 9475.7 9523.0 9651.0 9766.3 9152.5 9857.3 9977.8 10051.3 10135.9 2711.8 2813.3 2817.5 2818.9 2872.8 1013.9 1033.1 1037.2 1043.8 1048.8 22023.4 22027.2 22137.9 22169.6 22260.8 1119.9 1120.7 1124.3 1125.4 1137.2 11999.7 12054.8 12168.3 12168.8 12208.1 564445.0 573895.0 586006.0 590599.0 601051.0 130475.0 135559.0 135666.0 135720.0 136195.0 1109.5 1247.1 1266.0 1279.2 1284.5 23195.5 23219.4 23323.2 23424.1 23461.0 59931.4 60876.4 61346.0 62494.7 63217.7 73659.6 77024.0 77465.0 77747.0 77870.6 13163.3 13597.7 14223.6 14646.9 15417.7 24346.8 24361.0 24405.3 24466.3 24757.0 18537.4 18702.9 18981.7 19010.7 19012.1 17167.9 17168.2 17823.6 18007.6 18055.0 19092.8 19137.6 19211.3 19318.5 20494.6 14152.2 14153.9 14177.9 14214.6 14348.5 20206.2 20539.3 20550.8 20745.8 20749.7 15:58:59 INFO - PID 16588 | 15:58:59 INFO - PID 16588 | [#3] mootools.html Cycles:180 Average:10148.21 Median:2534.88 stddev:7482.26 (295.2%) stddev-sans-first:7474.68 15:58:59 INFO - PID 16588 | Values: 1444.9 1530.1 1545.0 1553.9 1556.4 15507.7 16128.1 16168.8 16232.9 16407.9 16663.8 16963.4 16969.9 16992.2 17043.7 2667.2 2719.2 2719.8 2719.9 2720.5 2513.5 2556.3 2613.2 2702.4 2711.0 2635.8 2667.8 2681.0 2687.9 2696.0 2621.2 2623.0 2637.7 2638.2 2667.7 2572.5 2610.1 2621.8 2652.2 2654.2 16281.3 16397.9 16402.2 16410.0 16417.8 8225.7 8492.4 8502.6 8510.3 8510.9 5007.3 5268.5 5334.1 5350.6 5372.4 1799.3 1805.8 1826.9 1852.2 1865.5 28819.3 29005.7 29035.6 29177.7 29206.4 6964.6 7463.3 7486.6 7713.1 7837.4 19192.1 19277.5 19425.1 19452.4 19466.2 8251.8 8384.5 8385.0 8481.9 8485.0 7668.2 7728.3 7741.8 7746.1 7773.9 5203.7 5478.8 5482.8 5485.4 5489.8 1400.1 1414.9 1492.1 1502.4 1507.6 861.6 879.9 891.8 895.1 903.2 8438.9 8882.2 8919.5 8965.0 9036.0 1003.7 1049.6 1056.2 1063.2 1091.1 4537.2 5382.7 5655.2 5764.9 5870.2 24011.9 24381.8 24414.6 24839.5 24887.6 22991.3 23391.9 23740.4 24110.3 24130.3 12362.0 12565.2 12693.0 12869.2 12872.8 8636.9 9151.5 9160.5 9226.9 9303.5 20508.7 20648.5 20662.6 20666.7 21131.0 21130.7 21308.6 21563.6 21586.1 22180.1 13252.0 13316.7 13603.5 13604.9 13614.7 13497.1 14859.1 15127.2 15151.4 15178.8 10326.8 11594.1 11694.0 11868.5 11901.3 11374.4 11502.3 11649.7 11701.2 11881.0 10443.5 10543.9 10575.9 10589.3 10591.6 8005.4 8040.4 8089.3 8111.5 8265.0 8124.6 8216.5 8224.2 8268.1 8334.7 15:58:59 INFO - PID 16588 | 15:58:59 INFO - PID 16588 | [#4] prototype.html Cycles:180 Average:5491.09 Median:6177.65 stddev:1588.12 (25.7%) stddev-sans-first:1547.85 15:58:59 INFO - PID 16588 | Values: 505.2 506.6 528.3 533.4 537.8 6048.4 6085.9 6101.8 6111.4 6113.5 6008.9 6076.6 6110.9 6117.6 6151.7 4817.1 4820.8 4827.8 4844.2 4869.3 4551.4 4627.9 4760.1 4800.4 4811.7 4621.4 4628.6 4636.0 4667.0 4688.3 4635.3 4648.5 4656.7 4670.2 4699.8 4109.2 4211.8 4234.5 4245.4 4259.7 5761.9 5796.0 5840.0 5871.3 5896.7 5442.8 5518.8 5549.3 5606.9 5652.7 6396.7 6450.3 6502.5 6511.4 6512.6 4802.7 4816.2 4835.1 4871.8 4884.4 6548.6 6672.0 6705.9 6718.3 6763.9 4939.0 4964.4 4989.5 5005.0 5021.3 5020.0 5039.4 5053.5 5055.0 5069.8 5565.4 5580.4 5584.0 5616.6 5619.9 6497.5 6518.4 6564.6 6586.5 6587.5 1711.9 1731.9 1734.2 1753.6 1758.4 1132.7 1194.3 1205.0 1213.6 1225.8 6171.1 6204.7 6222.9 6231.3 6288.3 6528.9 6557.8 6590.9 6599.8 6640.2 6184.2 6219.0 6300.2 6306.7 6334.8 3470.9 3503.7 3512.9 3533.4 3557.8 7013.8 7015.8 7022.8 7098.6 7102.6 6739.4 6792.7 6799.5 6858.8 6893.8 6944.4 7013.8 7072.9 7082.4 7133.5 6552.6 6581.0 6643.2 6663.5 6695.3 6668.6 6670.7 6698.6 6722.4 6729.1 6355.3 6999.5 7005.2 7019.4 7038.7 4890.6 4893.3 4911.5 4917.7 4924.8 6347.7 6485.8 6533.7 6629.5 6784.9 6335.2 6387.2 6417.9 6467.8 6472.8 6367.4 6397.7 6430.5 6473.5 6486.7 6391.8 6395.8 6451.6 6511.8 6550.5 6471.7 6476.7 6544.4 6546.4 6602.2 6367.8 6377.6 6388.8 6410.7 6415.2 15:58:59 INFO - PID 16588 | 15:58:59 INFO - PID 16588 | [#5] yui.html Cycles:180 Average:26976.06 Median:19668.56 stddev:38376.69 (195.1%) stddev-sans-first:38434.56 15:58:59 INFO - PID 16588 | Values: 942.0 950.7 980.9 981.0 990.3 17325.2 17417.0 17454.1 17595.0 21967.7 20720.3 22547.4 22687.4 22723.9 22876.2 1057.6 1085.7 1089.3 1089.4 1089.7 998.5 1077.9 1091.3 1092.8 1093.2 1128.7 1132.4 1133.9 1135.6 1136.3 1126.9 1126.9 1128.5 1129.4 1131.5 828.2 828.2 830.7 830.8 831.2 17997.1 18005.4 18108.5 19327.6 21359.8 22050.8 22060.7 22222.9 22652.8 22666.9 15589.5 15944.1 16100.1 16100.2 16619.3 3884.3 3913.7 3914.1 3914.7 3915.6 146182.0 149851.3 150736.0 151927.0 153771.0 16455.9 16466.3 17076.4 17081.0 17082.8 33362.5 33766.0 33980.8 33987.2 34093.1 9039.9 9187.0 9191.6 9201.3 9223.9 4359.7 4396.9 4422.3 4425.6 4430.2 5784.6 5871.3 5916.8 5922.3 5936.9 1035.5 1076.5 1086.4 1086.8 1090.2 652.5 664.4 678.2 686.8 693.7 12101.9 12637.6 12702.9 13005.9 13156.1 742.0 745.7 748.6 751.0 759.4 5615.6 5656.2 5820.8 5861.6 5938.9 121566.0 128208.0 131535.0 133812.0 135481.3 118116.4 119622.4 119814.0 120966.4 121537.4 99572.5 100037.0 100409.5 101055.5 102204.5 13789.2 14081.9 14094.9 14121.6 14137.4 50836.7 51072.7 51414.4 51544.5 52330.5 66899.0 67565.7 67662.0 86598.0 86637.0 18555.5 18829.8 18883.5 19033.5 19853.5 21025.2 21182.0 21193.4 21341.6 23409.6 19978.2 21468.4 21802.6 21952.7 22186.0 17366.7 17681.1 18111.6 18263.5 18482.4 19483.6 19935.6 19993.5 20164.0 20335.4 13528.4 14696.3 14745.4 14826.8 15132.4 13643.5 15343.8 15691.7 15701.0 16288.8 15:58:59 INFO - PID 16588 | -------- Summary: end -------- 15:58:59 INFO - PID 16588 | 15:58:59 INFO - TEST-INFO | 16588: exit 0 15:59:00 INFO - TEST-OK | dromaeo_css | took 1109503ms 15:59:00 INFO - TEST-START | kraken 15:59:00 INFO - Initialising browser for kraken test... 15:59:00 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:33969/getInfo.html -profile /tmp/tmpXDuIE6/profile 15:59:00 INFO - TEST-INFO | started process 16991 (/builds/slave/test/build/application/firefox/firefox http://localhost:33969/getInfo.html) 15:59:05 INFO - TEST-INFO | 16991: exit 0 15:59:05 INFO - Browser initialized. 15:59:05 INFO - Running cycle 1/1 for kraken test... 15:59:05 INFO - TEST-INFO | started process 17170 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXDuIE6/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 15:59:06 INFO - PID 17170 | 15:59:06 INFO - PID 17170 | (/builds/slave/test/build/application/firefox/firefox:17220): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 15:59:06 INFO - PID 17170 | 15:59:07 INFO - PID 17170 | 15:59:07 INFO - PID 17170 | (/builds/slave/test/build/application/firefox/firefox:17277): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 15:59:07 INFO - PID 17170 | 15:59:07 INFO - PID 17170 | __metrics Screen width/height:1600/1200 15:59:07 INFO - PID 17170 | colorDepth:24 15:59:07 INFO - PID 17170 | Browser inner width/height: 1024/768 15:59:07 INFO - PID 17170 | __metrics 15:59:17 INFO - PID 17170 | RSS: Main: 165699584 15:59:17 INFO - PID 17170 | 15:59:19 INFO - PID 17170 | Cycle 1(1): loaded http://localhost:33969/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:33969/tests/kraken/driver.html?testName=audio-beat-detection) 15:59:20 INFO - PID 17170 | RSS: Main: 169418752 15:59:20 INFO - PID 17170 | 15:59:23 INFO - PID 17170 | Cycle 1(1): loaded http://localhost:33969/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:33969/tests/kraken/driver.html?testName=audio-dft) 15:59:23 INFO - PID 17170 | RSS: Main: 172187648 15:59:23 INFO - PID 17170 | 15:59:26 INFO - PID 17170 | Cycle 1(1): loaded http://localhost:33969/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:33969/tests/kraken/driver.html?testName=audio-fft) 15:59:27 INFO - PID 17170 | RSS: Main: 165781504 15:59:27 INFO - PID 17170 | 15:59:29 INFO - PID 17170 | Cycle 1(1): loaded http://localhost:33969/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:33969/tests/kraken/driver.html?testName=audio-oscillator) 15:59:29 INFO - PID 17170 | RSS: Main: 166830080 15:59:29 INFO - PID 17170 | 15:59:32 INFO - PID 17170 | Cycle 1(1): loaded http://localhost:33969/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:33969/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:59:32 INFO - PID 17170 | RSS: Main: 166473728 15:59:32 INFO - PID 17170 | 15:59:35 INFO - PID 17170 | Cycle 1(1): loaded http://localhost:33969/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:33969/tests/kraken/driver.html?testName=imaging-darkroom) 15:59:36 INFO - PID 17170 | RSS: Main: 166588416 15:59:36 INFO - PID 17170 | 15:59:39 INFO - PID 17170 | Cycle 1(1): loaded http://localhost:33969/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:33969/tests/kraken/driver.html?testName=imaging-desaturate) 15:59:40 INFO - PID 17170 | RSS: Main: 168075264 15:59:40 INFO - PID 17170 | 15:59:43 INFO - PID 17170 | Cycle 1(1): loaded http://localhost:33969/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:33969/tests/kraken/driver.html?testName=json-parse-financial) 15:59:43 INFO - PID 17170 | RSS: Main: 168587264 15:59:43 INFO - PID 17170 | 15:59:45 INFO - PID 17170 | Cycle 1(1): loaded http://localhost:33969/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:33969/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:59:45 INFO - PID 17170 | RSS: Main: 167776256 15:59:45 INFO - PID 17170 | 15:59:47 INFO - PID 17170 | Cycle 1(1): loaded http://localhost:33969/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:33969/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:59:48 INFO - PID 17170 | RSS: Main: 168198144 15:59:48 INFO - PID 17170 | 15:59:50 INFO - PID 17170 | Cycle 1(1): loaded http://localhost:33969/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:33969/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:59:50 INFO - PID 17170 | RSS: Main: 168374272 15:59:50 INFO - PID 17170 | 15:59:53 INFO - PID 17170 | Cycle 1(1): loaded http://localhost:33969/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:33969/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:59:54 INFO - PID 17170 | RSS: Main: 168083456 15:59:54 INFO - PID 17170 | 15:59:57 INFO - PID 17170 | Cycle 1(1): loaded http://localhost:33969/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:33969/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:59:57 INFO - PID 17170 | RSS: Main: 168357888 15:59:57 INFO - PID 17170 | 15:59:59 INFO - PID 17170 | Cycle 1(1): loaded http://localhost:33969/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:33969/tests/kraken/driver.html?testName=ai-astar) 15:59:59 INFO - PID 17170 | RSS: Main: 170090496 15:59:59 INFO - PID 17170 | 15:59:59 INFO - PID 17170 | __start_tp_report 15:59:59 INFO - PID 17170 | _x_x_mozilla_page_load 15:59:59 INFO - PID 17170 | _x_x_mozilla_page_load_details 15:59:59 INFO - PID 17170 | |i|pagename|runs| 15:59:59 INFO - PID 17170 | |0;ai-astar;97;106;100;105;107;106;111;100;97;108 15:59:59 INFO - PID 17170 | |1;audio-beat-detection;145;121;139;165;113;143;142;113;167;116 15:59:59 INFO - PID 17170 | |2;audio-dft;163;164;163;163;168;164;165;163;166;171 15:59:59 INFO - PID 17170 | |3;audio-fft;73;73;73;174;76;73;79;90;96;73 15:59:59 INFO - PID 17170 | |4;audio-oscillator;78;78;128;78;77;77;124;82;78;130 15:59:59 INFO - PID 17170 | |5;imaging-gaussian-blur;114;114;116;114;115;114;114;114;114;113 15:59:59 INFO - PID 17170 | |6;imaging-darkroom;148;149;159;151;151;149;148;148;149;149 15:59:59 INFO - PID 17170 | |7;imaging-desaturate;94;95;94;103;94;94;94;94;94;93 15:59:59 INFO - PID 17170 | |8;json-parse-financial;48;47;47;47;47;50;47;47;51;54 15:59:59 INFO - PID 17170 | |9;json-stringify-tinderbox;54;55;54;54;54;54;54;53;54;54 15:59:59 INFO - PID 17170 | |10;stanford-crypto-aes;73;73;74;72;73;72;73;74;74;72 15:59:59 INFO - PID 17170 | |11;stanford-crypto-ccm;123;118;114;111;118;111;113;118;113;154 15:59:59 INFO - PID 17170 | |12;stanford-crypto-pbkdf2;163;162;164;162;172;171;164;167;159;162 15:59:59 INFO - PID 17170 | |13;stanford-crypto-sha256-iterative;61;61;61;62;59;61;60;61;61;60 15:59:59 INFO - PID 17170 | __end_tp_report 15:59:59 INFO - PID 17170 | __start_cc_report 15:59:59 INFO - PID 17170 | _x_x_mozilla_cycle_collect,892 15:59:59 INFO - PID 17170 | __end_cc_report 15:59:59 INFO - PID 17170 | __startTimestamp1503269999582__endTimestamp 15:59:59 INFO - PID 17170 | 15:59:59 INFO - PID 17170 | ------- Summary: start ------- 15:59:59 INFO - PID 17170 | Number of tests: 14 15:59:59 INFO - PID 17170 | 15:59:59 INFO - PID 17170 | [#0] ai-astar Cycles:10 Average:103.70 Median:107.50 stddev:4.85 (4.5%) stddev-sans-first:4.50 15:59:59 INFO - PID 17170 | Values: 97.0 106.0 100.0 105.0 107.0 106.0 111.0 100.0 97.0 108.0 15:59:59 INFO - PID 17170 | 15:59:59 INFO - PID 17170 | [#1] audio-beat-detection Cycles:10 Average:136.40 Median:142.50 stddev:20.16 (14.1%) stddev-sans-first:21.14 15:59:59 INFO - PID 17170 | Values: 145.0 121.0 139.0 165.0 113.0 143.0 142.0 113.0 167.0 116.0 15:59:59 INFO - PID 17170 | 15:59:59 INFO - PID 17170 | [#2] audio-dft Cycles:10 Average:165.00 Median:164.50 stddev:2.67 (1.6%) stddev-sans-first:2.73 15:59:59 INFO - PID 17170 | Values: 163.0 164.0 163.0 163.0 168.0 164.0 165.0 163.0 166.0 171.0 15:59:59 INFO - PID 17170 | 15:59:59 INFO - PID 17170 | [#3] audio-fft Cycles:10 Average:88.00 Median:74.50 stddev:31.29 (42.0%) stddev-sans-first:32.72 15:59:59 INFO - PID 17170 | Values: 73.0 73.0 73.0 174.0 76.0 73.0 79.0 90.0 96.0 73.0 15:59:59 INFO - PID 17170 | 15:59:59 INFO - PID 17170 | [#4] audio-oscillator Cycles:10 Average:93.00 Median:78.00 stddev:23.78 (30.5%) stddev-sans-first:24.59 15:59:59 INFO - PID 17170 | Values: 78.0 78.0 128.0 78.0 77.0 77.0 124.0 82.0 78.0 130.0 15:59:59 INFO - PID 17170 | 15:59:59 INFO - PID 17170 | [#5] imaging-gaussian-blur Cycles:10 Average:114.20 Median:114.00 stddev:0.79 (0.7%) stddev-sans-first:0.83 15:59:59 INFO - PID 17170 | Values: 114.0 114.0 116.0 114.0 115.0 114.0 114.0 114.0 114.0 113.0 15:59:59 INFO - PID 17170 | 15:59:59 INFO - PID 17170 | [#6] imaging-darkroom Cycles:10 Average:150.10 Median:149.00 stddev:3.31 (2.2%) stddev-sans-first:3.43 15:59:59 INFO - PID 17170 | Values: 148.0 149.0 159.0 151.0 151.0 149.0 148.0 148.0 149.0 149.0 15:59:59 INFO - PID 17170 | 15:59:59 INFO - PID 17170 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:94.00 stddev:2.88 (3.1%) stddev-sans-first:3.04 15:59:59 INFO - PID 17170 | Values: 94.0 95.0 94.0 103.0 94.0 94.0 94.0 94.0 94.0 93.0 15:59:59 INFO - PID 17170 | 15:59:59 INFO - PID 17170 | [#8] json-parse-financial Cycles:10 Average:48.50 Median:47.50 stddev:2.42 (5.1%) stddev-sans-first:2.55 15:59:59 INFO - PID 17170 | Values: 48.0 47.0 47.0 47.0 47.0 50.0 47.0 47.0 51.0 54.0 15:59:59 INFO - PID 17170 | 15:59:59 INFO - PID 17170 | [#9] json-stringify-tinderbox Cycles:10 Average:54.00 Median:54.00 stddev:0.47 (0.9%) stddev-sans-first:0.50 15:59:59 INFO - PID 17170 | Values: 54.0 55.0 54.0 54.0 54.0 54.0 54.0 53.0 54.0 54.0 15:59:59 INFO - PID 17170 | 15:59:59 INFO - PID 17170 | [#10] stanford-crypto-aes Cycles:10 Average:73.00 Median:73.00 stddev:0.82 (1.1%) stddev-sans-first:0.87 15:59:59 INFO - PID 17170 | Values: 73.0 73.0 74.0 72.0 73.0 72.0 73.0 74.0 74.0 72.0 15:59:59 INFO - PID 17170 | 15:59:59 INFO - PID 17170 | [#11] stanford-crypto-ccm Cycles:10 Average:119.30 Median:118.00 stddev:12.77 (10.8%) stddev-sans-first:13.48 15:59:59 INFO - PID 17170 | Values: 123.0 118.0 114.0 111.0 118.0 111.0 113.0 118.0 113.0 154.0 15:59:59 INFO - PID 17170 | 15:59:59 INFO - PID 17170 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:164.60 Median:164.00 stddev:4.17 (2.5%) stddev-sans-first:4.38 15:59:59 INFO - PID 17170 | Values: 163.0 162.0 164.0 162.0 172.0 171.0 164.0 167.0 159.0 162.0 15:59:59 INFO - PID 17170 | 15:59:59 INFO - PID 17170 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:60.70 Median:61.00 stddev:0.82 (1.3%) stddev-sans-first:0.87 15:59:59 INFO - PID 17170 | Values: 61.0 61.0 61.0 62.0 59.0 61.0 60.0 61.0 61.0 60.0 15:59:59 INFO - PID 17170 | -------- Summary: end -------- 15:59:59 INFO - PID 17170 | 15:59:59 INFO - PID 17170 | 15:59:59 INFO - PID 17170 | ###!!! [Parent][MessageChannel] Error: (msgtype=0x150079,name=PBrowser::Msg_Destroy) Closed channel: cannot send/recv 15:59:59 INFO - PID 17170 | 15:59:59 INFO - PID 17170 | 15:59:59 INFO - PID 17170 | ###!!! [Child][MessageChannel] Error: (msgtype=0x150001,name=PBrowser::Msg_AsyncMessage) Closed channel: cannot send/recv 15:59:59 INFO - PID 17170 | 15:59:59 INFO - PID 17170 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 16:00:00 INFO - TEST-INFO | 17170: exit 0 16:00:00 INFO - TEST-OK | kraken | took 60283ms 16:00:00 INFO - SUITE-END | took 1169s 16:00:00 INFO - Completed test suite (00:19:30) 16:00:00 INFO - javascript benchmark 16:00:00 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8887.355382982692, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3374.8481318340673, 3527.4532447470633, 3548.6273941236154, 3552.46712993051, 3573.7141028717706, 6158.6920653967345, 6166.814995550135, 6240.843978900524, 6254.343293954137, 6285.905711414327, 6133.1413602095745, 6196.752129914798, 6197.535184861143, 6199.566030377875, 6213.751449942009, 5480.671159730429, 5567.053600887839, 5568.610197286202, 5586.972065139689, 5605.327360716719, 5408.432114627966, 5458.4541545845295, 5525.585581081415, 5530.446955304457, 5621.662700237978, 5410.161424979135, 5466.808661696821, 5488.506034456878, 5492.450754924515, 5515.117581187011, 5530.5299049580835, 5541.418151094117, 5549.889002219973, 5618.9604923088955, 5622.044252477048, 5431.34823821144, 5471.890562188773, 5487.725613719298, 5508.3114610673665, 5573.498385145316, 6189.721462534197, 6203.689815509251, 6218.315985241665, 6232.844178895564, 6238.376162383771, 6730.32696730323, 6751.864962700768, 6821.488388370892, 6825.965870170618, 6842.7605033823575, 6717.56335838169, 6791.3548212919695, 6793.082933803923, 6798.694058767367, 6833.829154271133, 6388.488920886318, 6396.136521569575, 6397.136386587844, 6400.871982560369, 6407.359264073602, 6965.442764578822, 6969.6515174241085, 6979.965100174467, 7079.469039822034, 7081.150261968597, 6541.084248205255, 6668.566543174678, 6706.061151438803, 6775.695093720795, 6802.863942721118, 6710.496712746563, 6759.864802703918, 6801.5238933274195, 6808.931910680929, 6829.351211634887, 6737.0, 6741.460683145337, 6809.591424514545, 6827.180738311435, 6829.624370659562, 6662.933370666328, 6749.865002700017, 6755.4257888080065, 6844.965775171192, 6850.006749021364, 4870.9269360959615, 4872.4640289568115, 4900.191468407673, 4903.754812259373, 4909.729964851967, 4339.132173565299, 4368.4102646143, 4385.232584297799, 4390.3414487827085, 4424.60178583929, 6391.872162556723, 6409.0, 6477.319881412478, 6477.6437295948235, 6485.4487368573255, 6530.8040758777315, 6667.366600172976, 6732.259451460335, 6741.52809303344, 6801.9319806801295, 6488.545801793829, 6517.608943463408, 6521.673916304166, 6523.3150519194805, 6550.967245163743, 5473.808416705396, 5532.6680399176175, 5533.972330138404, 5548.91676624851, 5574.526165275915, 7137.286271372925, 7179.31796479344, 7218.67515961783, 7250.854982900312, 7253.274672532704, 6628.8674226515195, 6750.594964302158, 6760.18877734675, 6834.111565496453, 6840.794776156723, 7184.568925864465, 7258.056452661121, 7260.745873894389, 7263.128424589083, 7270.527415718173, 6699.363560461748, 6723.798286051427, 6724.697388617622, 6734.4949128816515, 6798.116244888331, 6735.090762746966, 6797.286284940208, 6868.484863635347, 6942.236354000955, 6953.33943275388, 6590.077389165424, 6676.6661666917435, 6697.7655782047395, 6704.597724136567, 6709.4632429404555, 6496.317886621837, 6650.966745166436, 6674.132362793, 6679.298673639198, 6682.498812588978, 6596.5052621052655, 6597.439217666552, 6608.933910660832, 6677.165354330708, 6682.0, 6504.317046710027, 6513.088167656437, 6579.572327798678, 6581.14445122131, 6585.736570537317, 6397.424231819158, 6404.743810247538, 6412.166418365583, 6421.133147025279, 6468.6442245676935], "value": 6178.807016256111, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [890.2032680750729, 893.1071581212326, 919.5310391700233, 952.3143336797513, 953.7663272498239, 40758.184836303255, 41933.16133677325, 42025.57974420255, 42306.0, 42338.7883060585, 43656.56343436565, 44016.55983440165, 44084.11831763363, 44135.0, 44137.0, 7578.469507134489, 7742.458027938046, 7748.845023099535, 7749.728759493419, 7751.069871615414, 7535.397168226528, 7616.695332186706, 7627.389808815282, 7633.885491717629, 7636.160022397532, 7643.46495745298, 7659.923400765977, 7661.387089032864, 7668.769936901902, 7671.731489397872, 7599.582022988733, 7621.885671714928, 7654.923450765505, 7670.846583068307, 7682.500637458603, 7513.2862378074, 7579.54522728638, 7585.089789225328, 7586.279303466162, 7591.2029236929875, 39852.800735996134, 40121.59878401208, 40145.0, 40170.39744403836, 40195.598044019476, 3415.8975230743117, 3456.948145777815, 3457.533233013536, 3457.8098204598737, 3458.481227815848, 31298.21754456134, 31373.84313078443, 31392.21519462009, 31440.0, 31440.685593144004, 5119.897602047976, 5133.153029750124, 5155.74221288934, 5181.5854731621375, 5190.221466779975, 190687.0, 192244.0, 192580.0, 194127.0, 210803.9459802722, 51145.0, 51256.0, 51267.23099153516, 51320.0, 51332.23001654978, 52506.47493525016, 52748.20877686838, 52754.0, 52803.47196528062, 52912.20631690528, 16429.91785041067, 16561.6687666246, 16561.66876662484, 16573.83426165723, 16772.412965546147, 13723.245221512712, 13760.380782864795, 13762.65593360174, 13770.31148442594, 13799.655008624864, 13382.397792099378, 13394.263315517544, 13406.396712147976, 13440.0, 13519.932400337935, 5264.078786212397, 5275.63070585063, 5316.973415132899, 5317.654352467077, 5339.946600533945, 1061.0662616897082, 1076.262760009396, 1082.9404382759024, 1089.7548051688307, 1092.781548573335, 23535.17626883051, 23749.762502374757, 24118.0, 24214.757852421604, 24381.0, 1157.386585109893, 1182.5033485935928, 1186.3475088701352, 1189.821526770974, 1199.7409197349375, 12433.067519936041, 12702.936485317514, 12709.491620335082, 12791.872081279254, 12854.550090746967, 247331.0, 249019.0, 249297.0, 249571.0, 251201.0, 53789.46210537844, 53991.0, 54009.189862152096, 54010.18984715232, 54280.72859635676, 1511.833698293187, 1521.0873475914584, 1533.4632878492662, 1555.066959824119, 1561.718890599703, 23817.285481435585, 29227.70772292335, 29278.0, 29368.118956431343, 30156.69843301539, 52200.738996304775, 52351.73824130855, 52358.47641523536, 52480.21279680732, 52614.473855260956, 216582.0, 216679.0, 216963.0, 216998.0, 217676.0, 33227.83386083054, 34352.62589496392, 34430.0, 35425.64574354327, 35630.28739425249, 46524.53475465202, 46938.0, 47411.28883066826, 47769.52230477651, 47885.28172077491, 34474.482882756274, 34916.82541587276, 34918.30163396768, 35067.47398789071, 35332.82333588316, 34309.65690343164, 34515.654843451244, 34525.65474345224, 34571.82714086514, 34903.650963491054, 39819.20361592694, 39931.60068399279, 40166.598334016286, 40257.19485610213, 40363.19273614453, 33315.0, 33622.0, 33726.83136584301, 33917.66082339145, 34351.0, 24584.385390365384, 26335.473290534464, 26426.867865660548, 26615.733842661324, 26644.333891652863], "value": 18003.169593272607, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [529.4229290073819, 552.8313864271396, 560.2045095963731, 574.6753084507255, 591.4085914085914, 22537.77462225377, 23360.299191024274, 23406.0637574497, 23434.29697109085, 23870.5225895482, 26195.47609047818, 26725.86637066817, 26842.060527881527, 26914.327141821464, 26960.730392696067, 6124.938750612492, 6238.8440288992915, 6250.374962503736, 6253.1870856788555, 6257.280412752523, 6004.939950600482, 6248.468880145193, 6260.937390626081, 6270.529710271725, 6272.435480806726, 6226.315105338409, 6233.158523599302, 6233.189685340899, 6234.345393733661, 6237.750489980395, 6194.9070763938125, 6221.657808820536, 6222.502199824025, 6223.190985171944, 6224.284207316171, 5762.394948530386, 5767.567432442584, 5779.9422005779825, 5789.623674461147, 5794.913076303858, 30650.54024189639, 31685.366292674247, 31896.0, 31932.521012184836, 32429.837850810596, 2170.1319472211085, 2223.2552095048018, 2233.028632544832, 2233.7207849018873, 2248.3704562722464, 19626.0, 20702.0, 20706.896465517726, 20746.377608671763, 20798.688019679717, 2431.756824317572, 2490.4023034471597, 2505.949881002388, 2510.083819405904, 2514.924552263435, 157954.0, 165615.0, 165644.0, 165677.0, 166210.0, 14938.908552802617, 15468.071915685096, 15670.294836732375, 15707.450239241572, 15970.680586388207, 23884.164054258017, 23922.162724304566, 23926.88036559841, 23989.640155397683, 23992.76007239905, 10201.74495637615, 10379.377237365783, 10488.31825931312, 10804.945975270231, 11112.499937502831, 9316.301277404222, 9475.715728528156, 9522.952385238168, 9651.0, 9766.267529935283, 9152.542372881462, 9857.260705447121, 9977.80044399108, 10051.346662467062, 10135.949320253352, 2711.8372897626205, 2813.324802047494, 2817.4505971335802, 2818.943621127566, 2872.8132671376293, 1013.9087482126497, 1033.0702367868978, 1037.1754455207977, 1043.8068957242933, 1048.8007278617038, 22023.449413764785, 22027.229046983277, 22137.889310553343, 22169.556608867733, 22260.777392226195, 1119.9440027998567, 1120.7142178744368, 1124.2692250037542, 1125.4372813593204, 1137.1641843245209, 11999.700007499709, 12054.758904821854, 12168.330741809108, 12168.783121687937, 12208.145429820004, 564445.0, 573895.0, 586006.0, 590599.0, 601051.0, 130475.0, 135559.0, 135666.0, 135720.0, 136195.0, 1109.5062697099875, 1247.089624574066, 1265.9810102848464, 1279.174932168746, 1284.531146131674, 23195.53608927846, 23219.419514512272, 23323.183688570818, 23424.06303747831, 23461.0, 59931.40068599258, 60876.391236087075, 61346.0, 62494.68752656208, 63217.68391158015, 73659.63170184115, 77024.0, 77465.0, 77747.0, 77870.61064694867, 13163.341832908125, 13597.728045439233, 14223.573292801233, 14646.926765366105, 15417.69164616679, 24346.75653243445, 24361.0, 24405.26784196477, 24466.266012019667, 24757.009719611015, 18537.35119270819, 18702.906485467487, 18981.71527427062, 19010.714839277698, 19012.144453499903, 17167.914160429118, 17168.22742976594, 17823.554411139306, 18007.639847203245, 18055.0, 19092.8090719091, 19137.617247655246, 19211.32760353381, 19318.517037073623, 20494.590108198052, 14152.150870947364, 14153.929230353782, 14177.858221418066, 14214.644633884236, 14348.49780257686, 20206.19175232974, 20539.28112516055, 20550.794492054887, 20745.792542074385, 20749.68875466839], "value": 12601.3233732594, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1444.913305201688, 1530.1278271385315, 1544.9691006179876, 1553.8579144328924, 1556.3696702835352, 15507.68984620307, 16128.112953787537, 16168.757468637965, 16232.918835405835, 16407.91796041021, 16663.83336166638, 16963.406280780175, 16969.91515042426, 16992.150392480387, 17043.659126817456, 2667.186508115024, 2719.2250208690525, 2719.7688196503223, 2719.864006799652, 2720.469508445854, 2513.5098655762135, 2556.2586849813533, 2613.2290974162665, 2702.4459985702883, 2711.024031348713, 2635.815492915487, 2667.773239274664, 2681.048227879104, 2687.905923292685, 2696.042904768808, 2621.1612284069106, 2622.986885065572, 2637.709851916288, 2638.1689767723105, 2667.653205083346, 2572.511222867649, 2610.073423934514, 2621.777148942342, 2652.2308530526125, 2654.190471906068, 16281.348746050144, 16397.91801040999, 16402.179891005522, 16410.015399076092, 16417.753733694004, 8225.670973161066, 8492.447990880573, 8502.574871256413, 8510.319174466027, 8510.914890851074, 5007.32401125847, 5268.473152684739, 5334.07973129673, 5350.5987050971335, 5372.355317361902, 1799.3072667023291, 1805.8013618501955, 1826.9086545672662, 1852.2128095559333, 1865.5429419792101, 28819.27951801201, 29005.70994290051, 29035.56446653302, 29177.70822291771, 29206.415871682446, 6964.616946067914, 7463.253674632493, 7486.588237646873, 7713.074431068196, 7837.373010159174, 19192.13635386411, 19277.51806204828, 19425.125869335912, 19452.416427507196, 19466.221351145796, 8251.793705157419, 8384.455010424424, 8384.958075209584, 8481.915180848237, 8484.957575212084, 7668.233176682399, 7728.304452599293, 7741.7677469676, 7746.0704715433385, 7773.883391749128, 5203.687778733288, 5478.835634930959, 5482.835514934558, 5485.396606373296, 5489.835304940858, 1400.1249219237977, 1414.929253537319, 1492.082369342868, 1502.4290769507518, 1507.5778781941074, 861.586438509519, 879.9208071273616, 891.8305521950808, 895.1317222294364, 903.2187158108189, 8438.873416898752, 8882.245009174163, 8919.509426981449, 8964.955175224213, 9035.954820225857, 1003.6537394598852, 1049.5644307612408, 1056.2447849787438, 1063.1654151491043, 1091.1161958813386, 4537.228671125917, 5382.650127741685, 5655.236543066633, 5764.933487304862, 5870.236869206976, 24011.879940600185, 24381.756182437948, 24414.633780493306, 24839.5032099357, 24887.62668559973, 22991.310260692208, 23391.88304058469, 23740.406489837547, 24110.276691699277, 24130.276091717278, 12362.0, 12565.183263088053, 12693.048021398617, 12869.163504372185, 12872.806907896389, 8636.913630863612, 9151.496667683341, 9160.450372977642, 9226.861597075915, 9303.534823258946, 20508.692369614768, 20648.48378790542, 20662.58674826465, 20666.689999649716, 21131.04910279072, 21130.683039754724, 21308.57382852365, 21563.568728625025, 21586.136554537643, 22180.112795488, 13252.0, 13316.733665326832, 13603.455861765418, 13604.86395136036, 13614.659633509242, 13497.122687025312, 14859.108453492825, 15127.16800575979, 15151.393944242107, 15178.77231841501, 10326.793464130526, 11594.130440216848, 11694.0, 11868.465919033491, 11901.345426001653, 11374.43127843621, 11502.252353596989, 11649.708757281136, 11701.239419437708, 11881.0, 10443.477826108512, 10543.94728026355, 10575.947120264349, 10589.258751887293, 10591.629292974709, 8005.439619226831, 8040.3969702273735, 8089.312408445348, 8111.472754270953, 8264.958675206586, 8124.63439145228, 8216.507009579444, 8224.177582241968, 8268.131846156068, 8334.708285209988], "value": 7079.218686292369, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [505.24465923444455, 506.64915286878954, 528.2657106621796, 533.4265664410759, 537.806389699708, 6048.425399587043, 6085.908711369333, 6101.847453813657, 6111.388861113886, 6113.480354169896, 6008.879822403549, 6076.605020673653, 6110.938890611093, 6117.602355846867, 6151.692415379235, 4817.108834865544, 4820.783064762094, 4827.8310259140935, 4844.224924012159, 4869.269609558559, 4551.407007547348, 4627.930581041287, 4760.071786001731, 4800.399950006249, 4811.67678888305, 4621.399218101642, 4628.606568441686, 4635.953640463603, 4667.0, 4688.32019357193, 4635.327877457749, 4648.48866624671, 4656.650751193657, 4670.206064968964, 4699.825043739065, 4109.198706252282, 4211.831526738927, 4234.513031001444, 4245.363195520666, 4259.70182087254, 5761.884762304772, 5796.0, 5839.970800146015, 5871.266091738533, 5896.675682837442, 5442.755076021588, 5518.779248830082, 5549.334079910436, 5606.915896261559, 5652.74562644682, 6396.680165991728, 6450.322716114834, 6502.544821862424, 6511.38141876521, 6512.641804700739, 4802.735849528274, 4816.157172494834, 4835.081334546425, 4871.82948596801, 4884.389451318585, 6548.607083575001, 6672.0, 6705.865882682319, 6718.260991290954, 6763.932360676379, 4938.950610493921, 4964.404271487445, 4989.451160372429, 5005.0, 5021.297018417425, 5020.013092210129, 5039.395272567315, 5053.46938571452, 5055.0, 5069.847904562869, 5565.387807341189, 5580.414056524007, 5584.0, 5616.5787565932715, 5619.8876022480135, 6497.545171838021, 6518.413342799076, 6564.606123632598, 6586.473082153416, 6587.484878477977, 1711.9400820971207, 1731.9134043298036, 1734.2369357482667, 1753.614204874951, 1758.3757765993143, 1132.7338075552238, 1194.2834299420451, 1204.9939750301369, 1213.550986135118, 1225.822255772908, 6171.13604095427, 6204.689765511706, 6222.875542489125, 6231.283402408691, 6288.308286088527, 6528.934710652928, 6557.770478033246, 6590.90113648286, 6599.769008084694, 6640.169978752656, 6184.165137706442, 6218.968905155536, 6300.243970723451, 6306.653134077578, 6334.796388686135, 3470.9413628843445, 3503.684668379858, 3512.877049303262, 3533.381658209803, 3557.8043207623828, 7013.824654383579, 7015.824604384829, 7022.789316320519, 7098.574085554883, 7102.573845569179, 6739.359760822714, 6792.728290868409, 6799.456043516507, 6858.794236172923, 6893.75871844493, 6944.375006249462, 7013.754518591825, 7072.858542829012, 7082.433405327562, 7133.536320139175, 6552.57408268461, 6581.0, 6643.202815661958, 6663.533552651268, 6695.330466953265, 6668.566543174678, 6670.733170673313, 6698.5980841149685, 6722.361375669304, 6729.125213722381, 6355.269144048493, 6999.545029573062, 7005.159380874327, 7019.403350715246, 7038.718451261892, 4890.584300334512, 4893.290472881484, 4911.533404326583, 4917.680350777188, 4924.803007879645, 6347.7318470350265, 6485.837854053686, 6533.705983230861, 6629.4696424284975, 6784.932150678627, 6335.208098987627, 6387.201599800025, 6417.8716425672155, 6467.838304042437, 6472.805815825533, 6367.363263673596, 6397.680115994275, 6430.453411460078, 6473.514486413444, 6486.740530378732, 6391.808245752635, 6395.840103997437, 6451.580647257913, 6511.79531786621, 6550.47596192313, 6471.676416179266, 6476.740930362733, 6544.3782840630065, 6546.410823025951, 6602.1747281589805, 6367.840803979752, 6377.58545694547, 6388.776392826228, 6410.679466026773, 6415.230172379344], "value": 5026.067563002282, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [942.0466836467674, 950.6720181537368, 980.85287206919, 980.9944806573261, 990.3414229537356, 17325.22036508357, 17417.0, 17454.127293635316, 17594.999999999967, 21967.670484942737, 20720.27479038234, 22547.436314092116, 22687.432814179654, 22723.886380568114, 22876.19933302335, 1057.5928267616946, 1085.6580177244143, 1089.3028461784463, 1089.3572792052687, 1089.6785448292774, 998.4907697074472, 1077.8975997280286, 1091.2743025887814, 1092.7541303206754, 1093.191038631411, 1128.740389710367, 1132.3602164776917, 1133.880942501038, 1135.5514571744156, 1136.33524388233, 1126.8591426071741, 1126.8704099028635, 1128.4527004402858, 1129.3844854554288, 1131.519104380639, 828.159418190537, 828.2338836576143, 830.6635812495888, 830.7507747675734, 831.243568352796, 17997.1001449927, 18005.369812056517, 18108.547286317815, 19327.613447730968, 21359.786402135935, 22050.779492205194, 22060.669089963663, 22222.88888555547, 22652.773472265395, 22666.88666556673, 15589.454369097028, 15944.123073230967, 16100.114493702842, 16100.19499025044, 16619.252133654016, 3884.3202439573242, 3913.745606535566, 3914.099757055893, 3914.706397020206, 3915.5692873784146, 146182.0, 149851.25074374667, 150736.0, 151927.0, 153771.0, 16455.917720411322, 16466.259018344204, 17076.402325918534, 17081.0, 17082.829171708374, 33362.49956250658, 33765.987020389424, 33980.830095849364, 33987.15032124217, 34093.14767130841, 9039.909600903908, 9187.0, 9191.63233470667, 9201.263898888074, 9223.907760922304, 4359.716618419792, 4396.890077748082, 4422.29243321067, 4425.645948324126, 4430.224710675683, 5784.59507834456, 5871.324797648325, 5916.763329466859, 5922.2597175353085, 5936.910946335808, 1035.4667346316653, 1076.4510099849133, 1086.3699054548342, 1086.8206745886998, 1090.1605763562013, 652.5106170372221, 664.35225654986, 678.1997243253008, 686.7630667419733, 693.7225109956058, 12101.939490302491, 12637.557685480964, 12702.936485317514, 13005.934970325088, 13156.144850584873, 742.0427648333589, 745.6905384265469, 748.5620911766568, 750.9586972716553, 759.4342215049824, 5615.578831587647, 5656.208130861683, 5820.82537523875, 5861.5603829712945, 5938.910916336258, 121566.0, 128208.0, 131535.0, 133812.0, 135481.3225933864, 118116.40941795237, 119622.40188799174, 119814.0, 120966.39516802359, 121537.39231303787, 99572.50213748885, 100036.99999999854, 100409.49795250977, 101055.49472252592, 102204.48897755463, 13789.172649641054, 14081.859181408465, 14094.859051409765, 14121.576352709435, 14137.363818628392, 50836.74581627068, 51072.744636276584, 51414.42927853667, 51544.48455515547, 52330.47669523256, 66899.0, 67565.66217168883, 67662.0, 86598.0, 86637.0, 18555.536111597317, 18829.811701883355, 18883.527911802314, 19033.524161895508, 19853.503662407977, 21025.158993640696, 21182.0, 21193.36419907405, 21341.573168536852, 23409.648855266845, 19978.20087196496, 21468.355949321547, 21802.563948721254, 21952.670709939044, 22186.0, 17366.739498907275, 17681.11594420248, 18111.63776724432, 18263.54341141482, 18482.445526634223, 19483.61032779365, 19935.60128797445, 19993.500162496053, 20164.0, 20335.389938301876, 13528.39122239482, 14696.265186740835, 14745.410183592536, 14826.777598335817, 15132.394704211709, 13643.522476713268, 15343.846561534689, 15691.686166276382, 15700.979436336602, 16288.755668664742], "value": 9879.261572136762, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1465.4, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 106.0, 100.0, 105.0, 107.0, 106.0, 111.0, 100.0, 97.0, 108.0], "value": 103.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 121.0, 139.0, 165.0, 113.0, 143.0, 142.0, 113.0, 167.0, 116.0], "value": 136.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 164.0, 163.0, 163.0, 168.0, 164.0, 165.0, 163.0, 166.0, 171.0], "value": 165.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 73.0, 73.0, 174.0, 76.0, 73.0, 79.0, 90.0, 96.0, 73.0], "value": 88.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 78.0, 128.0, 78.0, 77.0, 77.0, 124.0, 82.0, 78.0, 130.0], "value": 93.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 116.0, 114.0, 115.0, 114.0, 114.0, 114.0, 114.0, 113.0], "value": 114.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 149.0, 159.0, 151.0, 151.0, 149.0, 148.0, 148.0, 149.0, 149.0], "value": 150.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 94.0, 103.0, 94.0, 94.0, 94.0, 94.0, 94.0, 93.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [48.0, 47.0, 47.0, 47.0, 47.0, 50.0, 47.0, 47.0, 51.0, 54.0], "value": 48.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, 53.0, 54.0, 54.0], "value": 54.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 73.0, 74.0, 72.0, 73.0, 72.0, 73.0, 74.0, 74.0, 72.0], "value": 73.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [123.0, 118.0, 114.0, 111.0, 118.0, 111.0, 113.0, 118.0, 113.0, 154.0], "value": 119.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 162.0, 164.0, 162.0, 172.0, 171.0, 164.0, 167.0, 159.0, 162.0], "value": 164.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 61.0, 62.0, 59.0, 61.0, 60.0, 61.0, 61.0, 60.0], "value": 60.7, "unit": "score"}]}]} 16:00:00 INFO - Return code: 0 16:00:00 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:00:00 INFO - # TBPL SUCCESS # 16:00:00 INFO - Running post-action listener: _package_coverage_data 16:00:00 INFO - Running post-action listener: _resource_record_post_action 16:00:00 INFO - [mozharness: 2017-08-20 23:00:00.871172Z] Finished run-tests step (success) 16:00:00 INFO - Running post-run listener: _resource_record_post_run 16:00:00 INFO - Total resource usage - Wall time: 1188s; CPU: 13.0%; Read bytes: 8192; Write bytes: 431497216; Read time: 20; Write time: 288180 16:00:00 INFO - TinderboxPrint: CPU usage
13.1% 16:00:00 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 20 16:00:00 INFO - TinderboxPrint: I/O write bytes / time
431,497,216 / 288,180 16:00:00 INFO - TinderboxPrint: CPU idle
8,233.6 (86.9%) 16:00:00 INFO - TinderboxPrint: CPU user
1,187.7 (12.5%) 16:00:00 INFO - TinderboxPrint: Swap in / out
0 / 0 16:00:00 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 108666880; Read time: 0; Write time: 106696 16:00:00 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 16:00:00 INFO - run-tests - Wall time: 1171s; CPU: 13.0%; Read bytes: 0; Write bytes: 322830336; Read time: 0; Write time: 181484 16:00:01 INFO - Running post-run listener: _upload_blobber_files 16:00:01 INFO - Blob upload gear active. 16:00:01 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:00:01 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 16:00:01 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'] 16:00:01 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 16:00:01 INFO - (blobuploader) - INFO - Open directory for files ... 16:00:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 16:00:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:00:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:00:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 16:00:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:00:02 INFO - (blobuploader) - INFO - Done attempting. 16:00:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 16:00:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:00:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:00:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 16:00:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:00:03 INFO - (blobuploader) - INFO - Done attempting. 16:00:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 16:00:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:00:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:00:04 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 16:00:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:00:04 INFO - (blobuploader) - INFO - Done attempting. 16:00:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:00:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:00:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:00:11 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:00:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:00:11 INFO - (blobuploader) - INFO - Done attempting. 16:00:11 INFO - (blobuploader) - INFO - Iteration through files over. 16:00:11 INFO - Return code: 0 16:00:11 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:00:11 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:00:11 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1456d86a943c468f20068bac9e60d149b970b280e6679e8a991baf6296324baa222782689b88dabc92eff43775dc09c8fced2f7fa8346268c3068fb38498b493", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4721b59f5262c144f2d605db4131024e38c02a8987f66657f1175104ac3a177834fe5be9d096cef7fb9ccd9dab8bb08a73677806dc1c5c95c6fe5e443397c323", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b91c40a92ed8152b00e66da6dbd824f8e66311850dac5e3e537b37bebdf740fb809b57fa20e8505a92c7c87de577e4b4201bb612e2a29e714fec357cc52547e2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e7c653240a3fcfef53d26ec1e7abacebb26ab81a4cd1517952e9ebb9095758c7d9f51c62872fd19d649801b40990c0e221b3b696eda3118fa2b5cd6c77c33a09"} 16:00:11 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:00:11 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:00:11 INFO - Contents: 16:00:11 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1456d86a943c468f20068bac9e60d149b970b280e6679e8a991baf6296324baa222782689b88dabc92eff43775dc09c8fced2f7fa8346268c3068fb38498b493", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4721b59f5262c144f2d605db4131024e38c02a8987f66657f1175104ac3a177834fe5be9d096cef7fb9ccd9dab8bb08a73677806dc1c5c95c6fe5e443397c323", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b91c40a92ed8152b00e66da6dbd824f8e66311850dac5e3e537b37bebdf740fb809b57fa20e8505a92c7c87de577e4b4201bb612e2a29e714fec357cc52547e2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e7c653240a3fcfef53d26ec1e7abacebb26ab81a4cd1517952e9ebb9095758c7d9f51c62872fd19d649801b40990c0e221b3b696eda3118fa2b5cd6c77c33a09"} 16:00:11 INFO - Running post-run listener: copy_logs_to_upload_dir 16:00:11 INFO - Copying logs to upload dir... 16:00:11 INFO - mkdir: /builds/slave/test/build/upload/logs 16:00:11 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1251.802234 ========= master_lag: -0.07 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 51 secs) (at 2017-08-20 16:00:10.423506) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-20 16:00:10.433661) ========= 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=781b77c4c33858b1f599d705000001c1-1503268342.742509-78226362 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/1456d86a943c468f20068bac9e60d149b970b280e6679e8a991baf6296324baa222782689b88dabc92eff43775dc09c8fced2f7fa8346268c3068fb38498b493", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4721b59f5262c144f2d605db4131024e38c02a8987f66657f1175104ac3a177834fe5be9d096cef7fb9ccd9dab8bb08a73677806dc1c5c95c6fe5e443397c323", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b91c40a92ed8152b00e66da6dbd824f8e66311850dac5e3e537b37bebdf740fb809b57fa20e8505a92c7c87de577e4b4201bb612e2a29e714fec357cc52547e2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e7c653240a3fcfef53d26ec1e7abacebb26ab81a4cd1517952e9ebb9095758c7d9f51c62872fd19d649801b40990c0e221b3b696eda3118fa2b5cd6c77c33a09"} build_url:https://queue.taskcluster.net/v1/task/VXxr4_LqSUqVGy4lHai7VQ/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011776 build_url: 'https://queue.taskcluster.net/v1/task/VXxr4_LqSUqVGy4lHai7VQ/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1456d86a943c468f20068bac9e60d149b970b280e6679e8a991baf6296324baa222782689b88dabc92eff43775dc09c8fced2f7fa8346268c3068fb38498b493", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4721b59f5262c144f2d605db4131024e38c02a8987f66657f1175104ac3a177834fe5be9d096cef7fb9ccd9dab8bb08a73677806dc1c5c95c6fe5e443397c323", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b91c40a92ed8152b00e66da6dbd824f8e66311850dac5e3e537b37bebdf740fb809b57fa20e8505a92c7c87de577e4b4201bb612e2a29e714fec357cc52547e2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e7c653240a3fcfef53d26ec1e7abacebb26ab81a4cd1517952e9ebb9095758c7d9f51c62872fd19d649801b40990c0e221b3b696eda3118fa2b5cd6c77c33a09"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-20 16:00:10.468360) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-20 16:00:10.468773) ========= 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=781b77c4c33858b1f599d705000001c1-1503268342.742509-78226362 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004479 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-20 16:00:10.550878) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-20 16:00:10.551215) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-20 16:00:10.551533) ========= ========= Total master_lag: 0.10 =========