builder: mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s slave: talos-linux64-ix-004 starttime: 1503362058.58 results: success (0) revision: 128a79130ecd6f277190d031a623f991c73c5272 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-08-21 17:34:18.576207) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-08-21 17:34:18.576636) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-21 17:34:18.576975) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-21 17:34:18.599172) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-21 17:34:18.599543) ========= 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=c6927cf182745ad25b1d38b9000001fe-1503362057.505580-1623270300 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-08-21 17:34:18-- 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% 42.5M=0s 2017-08-21 17:34:18 (42.5 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.126456 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-21 17:34:18.743333) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-21 17:34:18.743668) ========= 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=c6927cf182745ad25b1d38b9000001fe-1503362057.505580-1623270300 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020404 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-21 17:34:18.796832) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-08-21 17:34:18.797201) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 128a79130ecd6f277190d031a623f991c73c5272 --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 128a79130ecd6f277190d031a623f991c73c5272 --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=c6927cf182745ad25b1d38b9000001fe-1503362057.505580-1623270300 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-08-21 17:34:18,978 truncating revision to first 12 chars 2017-08-21 17:34:18,978 Setting DEBUG logging. 2017-08-21 17:34:18,978 attempt 1/10 2017-08-21 17:34:18,978 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/128a79130ecd?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-08-21 17:34:19,603 unpacking tar archive at: mozilla-central-128a79130ecd/testing/mozharness/ program finished with exit code 0 elapsedTime=1.011759 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-08-21 17:34:19.822674) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-21 17:34:19.826019) ========= script_repo_revision: 128a79130ecd6f277190d031a623f991c73c5272 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-21 17:34:19.826449) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-21 17:34:19.826709) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-21 17:34:19.846280) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2017-08-21 17:34:19.846632) ========= /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=c6927cf182745ad25b1d38b9000001fe-1503362057.505580-1623270300 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:34:20 INFO - MultiFileLogger online at 20170821 17:34:20 in /builds/slave/test 17:34:20 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 17:34:20 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:34:20 INFO - {'append_to_log': False, 17:34:20 INFO - 'base_work_dir': '/builds/slave/test', 17:34:20 INFO - 'blob_upload_branch': 'Firefox', 17:34:20 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:34:20 INFO - 'branch': 'Firefox', 17:34:20 INFO - 'buildbot_json_path': 'buildprops.json', 17:34:20 INFO - 'code_coverage': False, 17:34:20 INFO - 'config_files': ('talos/linux_config.py',), 17:34:20 INFO - 'default_actions': ('clobber', 17:34:20 INFO - 'read-buildbot-config', 17:34:20 INFO - 'download-and-extract', 17:34:20 INFO - 'populate-webroot', 17:34:20 INFO - 'create-virtualenv', 17:34:20 INFO - 'install', 17:34:20 INFO - 'setup-mitmproxy', 17:34:20 INFO - 'run-tests'), 17:34:20 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:34:20 INFO - 'disable_ccov_upload': False, 17:34:20 INFO - 'download_minidump_stackwalk': True, 17:34:20 INFO - 'download_symbols': 'ondemand', 17:34:20 INFO - 'enable_stylo': False, 17:34:20 INFO - 'enable_webrender': False, 17:34:20 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:34:20 INFO - 'tooltool.py': '/tools/tooltool.py', 17:34:20 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:34:20 INFO - '/tools/misc-python/virtualenv.py')}, 17:34:20 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:34:20 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:34:20 INFO - 'gecko_profile': False, 17:34:20 INFO - 'gecko_profile_interval': 0, 17:34:20 INFO - 'installer_path': 'installer.exe', 17:34:20 INFO - 'log_level': 'info', 17:34:20 INFO - 'log_name': 'talos', 17:34:20 INFO - 'log_to_console': True, 17:34:20 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:34:20 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:34:20 INFO - 'opt_config_files': (), 17:34:20 INFO - 'pip_index': False, 17:34:20 INFO - 'suite': 'dromaeojs-e10s', 17:34:20 INFO - 'system_bits': '32', 17:34:20 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:34:20 INFO - 'title': 'talos-linux64-ix-004', 17:34:20 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:34:20 INFO - 'use_talos_json': True, 17:34:20 INFO - 'verify': 'False', 17:34:20 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:34:20 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:34:20 INFO - 'work_dir': 'build'} 17:34:20 INFO - [mozharness: 2017-08-22 00:34:20.170427Z] Running clobber step. 17:34:20 INFO - Running pre-action listener: _resource_record_pre_action 17:34:20 INFO - Running main action method: clobber 17:34:20 INFO - rmtree: /builds/slave/test/build 17:34:20 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:34:21 INFO - Running post-action listener: _resource_record_post_action 17:34:21 INFO - [mozharness: 2017-08-22 00:34:21.728959Z] Finished clobber step (success) 17:34:21 INFO - [mozharness: 2017-08-22 00:34:21.729056Z] Running read-buildbot-config step. 17:34:21 INFO - Running pre-action listener: _resource_record_pre_action 17:34:21 INFO - Running main action method: read_buildbot_config 17:34:21 INFO - Using buildbot properties: 17:34:21 INFO - { 17:34:21 INFO - "project": "", 17:34:21 INFO - "product": "firefox", 17:34:21 INFO - "who": "kwierso@gmail.com", 17:34:21 INFO - "installer_path": "public/build/target.tar.bz2", 17:34:21 INFO - "builddir": "mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s", 17:34:21 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 17:34:21 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo mozilla-central talos dromaeojs-e10s", 17:34:21 INFO - "stage_platform": "linux64-stylo", 17:34:21 INFO - "basedir": "/builds/slave/test", 17:34:21 INFO - "buildnumber": 96, 17:34:21 INFO - "platform": "ubuntu64_hw_stylo", 17:34:21 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 17:34:21 INFO - "slavebuilddir": "test", 17:34:21 INFO - "taskId": "OEAu4IH-T4yYID03nebqlA", 17:34:21 INFO - "branch": "mozilla-central", 17:34:21 INFO - "script_repo_revision": "production", 17:34:21 INFO - "revision": "128a79130ecd6f277190d031a623f991c73c5272", 17:34:21 INFO - "slavename": "talos-linux64-ix-004", 17:34:21 INFO - "repo_path": "mozilla-central" 17:34:21 INFO - } 17:34:21 INFO - Finding installer, test and symbols from parent task. 17:34:21 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/OEAu4IH-T4yYID03nebqlA'}, attempt #1 17:34:22 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/OEAu4IH-T4yYID03nebqlA'}, attempt #1 17:34:22 INFO - Task dependencies: FkdMd0HTQmiwzY-YzIEfag 17:34:22 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FkdMd0HTQmiwzY-YzIEfag'}, attempt #1 17:34:23 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/FkdMd0HTQmiwzY-YzIEfag/artifacts/public/build/target.tar.bz2 17:34:23 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/FkdMd0HTQmiwzY-YzIEfag/artifacts/public/build/target.test_packages.json 17:34:23 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/FkdMd0HTQmiwzY-YzIEfag/artifacts/public/build/target.crashreporter-symbols.zip 17:34:23 INFO - Running post-action listener: _resource_record_post_action 17:34:23 INFO - [mozharness: 2017-08-22 00:34:23.093238Z] Finished read-buildbot-config step (success) 17:34:23 INFO - [mozharness: 2017-08-22 00:34:23.093497Z] Running download-and-extract step. 17:34:23 INFO - Running pre-action listener: _resource_record_pre_action 17:34:23 INFO - Running main action method: download_and_extract 17:34:23 INFO - mkdir: /builds/slave/test/build/tests 17:34:23 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')]} 17:34:23 INFO - trying https://queue.taskcluster.net/v1/task/FkdMd0HTQmiwzY-YzIEfag/artifacts/public/build/target.test_packages.json 17:34:23 INFO - Downloading https://queue.taskcluster.net/v1/task/FkdMd0HTQmiwzY-YzIEfag/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 17:34:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FkdMd0HTQmiwzY-YzIEfag/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 17:34:23 INFO - Downloaded 989 bytes. 17:34:23 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 17:34:23 INFO - Using the following test package requirements: 17:34:23 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 17:34:23 INFO - u'common': [u'target.common.tests.zip'], 17:34:23 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 17:34:23 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 17:34:23 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 17:34:23 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 17:34:23 INFO - u'mozbase': [u'target.common.tests.zip'], 17:34:23 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 17:34:23 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 17:34:23 INFO - u'web-platform': [u'target.common.tests.zip', 17:34:23 INFO - u'target.web-platform.tests.tar.gz'], 17:34:23 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 17:34:23 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 17:34:23 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/FkdMd0HTQmiwzY-YzIEfag/artifacts/public/build/target.common.tests.zip 17:34:23 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/FkdMd0HTQmiwzY-YzIEfag/artifacts/public/build/target.common.tests.zip'}, attempt #1 17:34:23 INFO - Fetch https://queue.taskcluster.net/v1/task/FkdMd0HTQmiwzY-YzIEfag/artifacts/public/build/target.common.tests.zip into memory 17:34:24 INFO - Content-Length response header: 54006118 17:34:24 INFO - Bytes received: 54006118 17:34:35 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 17:34:35 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/FkdMd0HTQmiwzY-YzIEfag/artifacts/public/build/target.common.tests.zip 17:34:35 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/FkdMd0HTQmiwzY-YzIEfag/artifacts/public/build/target.common.tests.zip'}, attempt #1 17:34:35 INFO - Fetch https://queue.taskcluster.net/v1/task/FkdMd0HTQmiwzY-YzIEfag/artifacts/public/build/target.common.tests.zip into memory 17:34:36 INFO - Content-Length response header: 54006118 17:34:36 INFO - Bytes received: 54006118 17:34:48 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/FkdMd0HTQmiwzY-YzIEfag/artifacts/public/build/target.talos.tests.zip 17:34:48 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/FkdMd0HTQmiwzY-YzIEfag/artifacts/public/build/target.talos.tests.zip'}, attempt #1 17:34:48 INFO - Fetch https://queue.taskcluster.net/v1/task/FkdMd0HTQmiwzY-YzIEfag/artifacts/public/build/target.talos.tests.zip into memory 17:34:49 INFO - Content-Length response header: 14496256 17:34:49 INFO - Bytes received: 14496256 17:34: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')]} 17:34:49 INFO - trying https://queue.taskcluster.net/v1/task/FkdMd0HTQmiwzY-YzIEfag/artifacts/public/build/target.tar.bz2 17:34:49 INFO - Downloading https://queue.taskcluster.net/v1/task/FkdMd0HTQmiwzY-YzIEfag/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 17:34:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FkdMd0HTQmiwzY-YzIEfag/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 17:34:50 INFO - Downloaded 62147374 bytes. 17:34:50 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/FkdMd0HTQmiwzY-YzIEfag/artifacts/public/build/target.tar.bz2 17:34:50 INFO - mkdir: /builds/slave/test/properties 17:34:50 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:34:50 INFO - Writing to file /builds/slave/test/properties/build_url 17:34:50 INFO - Contents: 17:34:50 INFO - build_url:https://queue.taskcluster.net/v1/task/FkdMd0HTQmiwzY-YzIEfag/artifacts/public/build/target.tar.bz2 17:34:50 INFO - Running post-action listener: _resource_record_post_action 17:34:50 INFO - Running post-action listener: find_tests_for_verification 17:34:50 INFO - Running post-action listener: set_extra_try_arguments 17:34:50 INFO - [mozharness: 2017-08-22 00:34:50.734161Z] Finished download-and-extract step (success) 17:34:50 INFO - [mozharness: 2017-08-22 00:34:50.734259Z] Running populate-webroot step. 17:34:50 INFO - Running pre-action listener: _resource_record_pre_action 17:34:50 INFO - Running main action method: populate_webroot 17:34:50 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:34:50 INFO - 'chromez-stylo-e10s': {'talos_options': ['--stylo'], 17:34:50 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:34:50 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:34:50 INFO - 'dromaeojs-stylo-e10s': {'talos_options': ['--stylo'], 17:34:50 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:34:50 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 17:34:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:34:50 INFO - 'g1-stylo-e10s': {'pagesets_name': 'tp5n.zip', 17:34:50 INFO - 'talos_options': ['--stylo'], 17:34:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:34:50 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 17:34:50 INFO - 'tests': ['damp', 'tps']}, 17:34:50 INFO - 'g2-stylo-e10s': {'pagesets_name': 'tp5n.zip', 17:34:50 INFO - 'talos_options': ['--stylo'], 17:34:50 INFO - 'tests': ['damp', 'tps']}, 17:34:50 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:34:50 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 17:34:50 INFO - 'g4-stylo-e10s': {'talos_options': ['--stylo'], 17:34:50 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 17:34:50 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 17:34:50 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 17:34:50 INFO - 'g5-stylo-e10s': {'pagesets_name': 'tp5n.zip', 17:34:50 INFO - 'talos_options': ['--stylo'], 17:34:50 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 17:34:50 INFO - 'other-e10s': {'tests': ['a11yr', 17:34:50 INFO - 'ts_paint', 17:34:50 INFO - 'tpaint', 17:34:50 INFO - 'sessionrestore', 17:34:50 INFO - 'sessionrestore_many_windows', 17:34:50 INFO - 'sessionrestore_no_auto_restore', 17:34:50 INFO - 'tabpaint']}, 17:34:50 INFO - 'other-stylo-e10s': {'talos_options': ['--stylo'], 17:34:50 INFO - 'tests': ['a11yr', 17:34:50 INFO - 'ts_paint', 17:34:50 INFO - 'tpaint', 17:34:50 INFO - 'sessionrestore', 17:34:50 INFO - 'sessionrestore_many_windows', 17:34:50 INFO - 'sessionrestore_no_auto_restore', 17:34:50 INFO - 'tabpaint']}, 17:34:50 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 17:34:50 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 17:34:50 INFO - 'perf-reftest-singletons-stylo-e10s': {'talos_options': ['--stylo'], 17:34:50 INFO - 'tests': ['bloom_basic_singleton']}, 17:34:50 INFO - 'perf-reftest-stylo-e10s': {'talos_options': ['--stylo'], 17:34:50 INFO - 'tests': ['bloom_basic']}, 17:34:50 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:34:50 INFO - 'tsvgr_opacity', 17:34:50 INFO - 'tart', 17:34:50 INFO - 'tscrollx', 17:34:50 INFO - 'tsvg_static']}, 17:34:50 INFO - 'svgr-stylo-e10s': {'talos_options': ['--stylo'], 17:34:50 INFO - 'tests': ['tsvgx', 17:34:50 INFO - 'tsvgr_opacity', 17:34:50 INFO - 'tart', 17:34:50 INFO - 'tscrollx', 17:34:50 INFO - 'tsvg_static']}, 17:34:50 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 17:34:50 INFO - 'tp5o-stylo-e10s': {'pagesets_name': 'tp5n.zip', 17:34:50 INFO - 'talos_options': ['--stylo'], 17:34:50 INFO - 'tests': ['tp5o']}, 17:34:50 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 17:34:50 INFO - 'talos_options': ['--mitmproxy', 17:34:50 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 17:34:50 INFO - '--firstNonBlankPaint'], 17:34:50 INFO - 'tests': ['tp6_google', 17:34:50 INFO - 'tp6_youtube', 17:34:50 INFO - 'tp6_amazon', 17:34:50 INFO - 'tp6_facebook']}, 17:34:50 INFO - 'tp6-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 17:34:50 INFO - 'talos_options': ['--stylo', 17:34:50 INFO - '--mitmproxy', 17:34:50 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 17:34:50 INFO - '--firstNonBlankPaint'], 17:34:50 INFO - 'tests': ['tp6_google', 17:34:50 INFO - 'tp6_youtube', 17:34:50 INFO - 'tp6_amazon', 17:34:50 INFO - 'tp6_facebook']}, 17:34:50 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 17:34:50 INFO - 'talos_options': ['--stylo', 17:34:50 INFO - '--stylo-threads=1', 17:34:50 INFO - '--mitmproxy', 17:34:50 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 17:34:50 INFO - '--firstNonBlankPaint'], 17:34:50 INFO - 'tests': ['tp6_google', 17:34:50 INFO - 'tp6_youtube', 17:34:50 INFO - 'tp6_amazon', 17:34:50 INFO - 'tp6_facebook']}, 17:34:50 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 17:34:50 INFO - 'talos_options': ['--xperf_path', 17:34:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:34:50 INFO - 'tests': ['tp5n']}, 17:34:50 INFO - 'xperf-stylo-e10s': {'pagesets_name': 'tp5n.zip', 17:34:50 INFO - 'talos_options': ['--stylo', 17:34:50 INFO - '--xperf_path', 17:34:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:34:50 INFO - 'tests': ['tp5n']}}} 17:34:50 INFO - Running post-action listener: _resource_record_post_action 17:34:50 INFO - [mozharness: 2017-08-22 00:34:50.748465Z] Finished populate-webroot step (success) 17:34:50 INFO - [mozharness: 2017-08-22 00:34:50.748555Z] Running create-virtualenv step. 17:34:50 INFO - Running pre-action listener: _resource_record_pre_action 17:34:50 INFO - Running main action method: create_virtualenv 17:34:50 INFO - Creating virtualenv /builds/slave/test/build/venv 17:34:50 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 17:34:50 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:34:50 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 17:34:50 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:34:50 INFO - Using real prefix '/usr' 17:34:50 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:34:51 INFO - Installing distribute.............................................................................................................................................................................................done. 17:34:53 INFO - Installing pip.................done. 17:34:53 INFO - Return code: 0 17:34:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 17:34:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 17:34:53 INFO - Reading from file tmpfile_stdout 17:34:53 INFO - Output received: 17:34:53 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 17:34:53 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:34:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:34:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:34:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:34:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:34:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x123f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x140aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15adf90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ab130>, '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 0x15ac030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15ac4c0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1503362057.505580-1623270300', '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 17:34:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 17:34:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 17:34:53 INFO - Using env: {'DISPLAY': ':0', 17:34:53 INFO - 'HOME': '/home/cltbld', 17:34:53 INFO - 'LANG': 'en_US.UTF-8', 17:34:53 INFO - 'LANGUAGE': 'en_US:en', 17:34:53 INFO - 'LOGNAME': 'cltbld', 17:34:53 INFO - 'MAIL': '/var/mail/cltbld', 17:34:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:34:53 INFO - 'MOZ_NO_REMOTE': '1', 17:34:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:34:53 INFO - 'NO_EM_RESTART': '1', 17:34:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:34:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:34:53 INFO - 'PWD': '/builds/slave/test', 17:34:53 INFO - 'SHELL': '/bin/bash', 17:34:53 INFO - 'SHLVL': '1', 17:34:53 INFO - 'TERM': 'linux', 17:34:53 INFO - 'TMOUT': '86400', 17:34:53 INFO - 'USER': 'cltbld', 17:34:53 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1503362057.505580-1623270300', 17:34:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:34:53 INFO - '_': '/tools/buildbot/bin/python'} 17:34:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:34:53 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 17:34:53 INFO - Cleaning up... 17:34:53 INFO - Return code: 0 17:34:53 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 17:34:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:34:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:34:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:34:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:34:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x123f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x140aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15adf90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ab130>, '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 0x15ac030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15ac4c0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1503362057.505580-1623270300', '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 17:34:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 17:34:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 17:34:53 INFO - Using env: {'DISPLAY': ':0', 17:34:53 INFO - 'HOME': '/home/cltbld', 17:34:53 INFO - 'LANG': 'en_US.UTF-8', 17:34:53 INFO - 'LANGUAGE': 'en_US:en', 17:34:53 INFO - 'LOGNAME': 'cltbld', 17:34:53 INFO - 'MAIL': '/var/mail/cltbld', 17:34:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:34:53 INFO - 'MOZ_NO_REMOTE': '1', 17:34:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:34:53 INFO - 'NO_EM_RESTART': '1', 17:34:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:34:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:34:53 INFO - 'PWD': '/builds/slave/test', 17:34:53 INFO - 'SHELL': '/bin/bash', 17:34:53 INFO - 'SHLVL': '1', 17:34:53 INFO - 'TERM': 'linux', 17:34:53 INFO - 'TMOUT': '86400', 17:34:53 INFO - 'USER': 'cltbld', 17:34:53 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1503362057.505580-1623270300', 17:34:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:34:53 INFO - '_': '/tools/buildbot/bin/python'} 17:34:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:34:53 INFO - Downloading/unpacking psutil>=3.1.1 17:34:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:34:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:34:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:34:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:34:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:34:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:34:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:34:55 INFO - Installing collected packages: psutil 17:34:55 INFO - Running setup.py install for psutil 17:34:55 INFO - building 'psutil._psutil_linux' extension 17:34:55 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 17:34:55 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 17:34:55 INFO - building 'psutil._psutil_posix' extension 17:34:55 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 17:34:55 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 17:34:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:34:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:34:55 INFO - Successfully installed psutil 17:34:55 INFO - Cleaning up... 17:34:55 INFO - Return code: 0 17:34:55 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 17:34: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')]} 17:34:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:34: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')]} 17:34:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:34:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x123f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x140aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15adf90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ab130>, '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 0x15ac030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15ac4c0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1503362057.505580-1623270300', '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 17:34:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 17:34:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 17:34:55 INFO - Using env: {'DISPLAY': ':0', 17:34:55 INFO - 'HOME': '/home/cltbld', 17:34:55 INFO - 'LANG': 'en_US.UTF-8', 17:34:55 INFO - 'LANGUAGE': 'en_US:en', 17:34:55 INFO - 'LOGNAME': 'cltbld', 17:34:55 INFO - 'MAIL': '/var/mail/cltbld', 17:34:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:34:55 INFO - 'MOZ_NO_REMOTE': '1', 17:34:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:34:55 INFO - 'NO_EM_RESTART': '1', 17:34:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:34:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:34:55 INFO - 'PWD': '/builds/slave/test', 17:34:55 INFO - 'SHELL': '/bin/bash', 17:34:55 INFO - 'SHLVL': '1', 17:34:55 INFO - 'TERM': 'linux', 17:34:55 INFO - 'TMOUT': '86400', 17:34:55 INFO - 'USER': 'cltbld', 17:34:55 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1503362057.505580-1623270300', 17:34:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:34:55 INFO - '_': '/tools/buildbot/bin/python'} 17:34:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:34:55 INFO - Downloading/unpacking mozsystemmonitor==0.3 17:34: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 17:34: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 17:34: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 17:34: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 17:34:57 INFO - Downloading mozsystemmonitor-0.3.tar.gz 17:34:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:34:57 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 17:34:57 INFO - Installing collected packages: mozsystemmonitor 17:34:57 INFO - Running setup.py install for mozsystemmonitor 17:34:57 INFO - Successfully installed mozsystemmonitor 17:34:57 INFO - Cleaning up... 17:34:57 INFO - Return code: 0 17:34:57 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 17:34: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')]} 17:34:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:34: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')]} 17:34:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:34:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x123f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x140aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15adf90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ab130>, '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 0x15ac030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15ac4c0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1503362057.505580-1623270300', '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 17:34:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 17:34:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 17:34:57 INFO - Using env: {'DISPLAY': ':0', 17:34:57 INFO - 'HOME': '/home/cltbld', 17:34:57 INFO - 'LANG': 'en_US.UTF-8', 17:34:57 INFO - 'LANGUAGE': 'en_US:en', 17:34:57 INFO - 'LOGNAME': 'cltbld', 17:34:57 INFO - 'MAIL': '/var/mail/cltbld', 17:34:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:34:57 INFO - 'MOZ_NO_REMOTE': '1', 17:34:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:34:57 INFO - 'NO_EM_RESTART': '1', 17:34:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:34:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:34:57 INFO - 'PWD': '/builds/slave/test', 17:34:57 INFO - 'SHELL': '/bin/bash', 17:34:57 INFO - 'SHLVL': '1', 17:34:57 INFO - 'TERM': 'linux', 17:34:57 INFO - 'TMOUT': '86400', 17:34:57 INFO - 'USER': 'cltbld', 17:34:57 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1503362057.505580-1623270300', 17:34:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:34:57 INFO - '_': '/tools/buildbot/bin/python'} 17:34:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:34:57 INFO - Downloading/unpacking jsonschema==2.5.1 17:34: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 17:34: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 17:34: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 17:34: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 17:34:58 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:34:58 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 17:34: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 17:34: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 17:34: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 17:34: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 17:34:58 INFO - Downloading functools32-3.2.3-2.tar.gz 17:34:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:34:58 INFO - warning: no files found matching '*.txt' 17:34:58 INFO - no previously-included directories found matching 'build' 17:34:58 INFO - no previously-included directories found matching 'dist' 17:34:58 INFO - no previously-included directories found matching '.git*' 17:34:58 INFO - Installing collected packages: jsonschema, functools32 17:34:59 INFO - Running setup.py install for functools32 17:34:59 INFO - warning: no files found matching '*.txt' 17:34:59 INFO - no previously-included directories found matching 'build' 17:34:59 INFO - no previously-included directories found matching 'dist' 17:34:59 INFO - no previously-included directories found matching '.git*' 17:34:59 INFO - Successfully installed jsonschema functools32 17:34:59 INFO - Cleaning up... 17:34:59 INFO - Return code: 0 17:34:59 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 17:34:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:34:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:34:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:34:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:34:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x123f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x140aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15adf90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ab130>, '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 0x15ac030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15ac4c0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1503362057.505580-1623270300', '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 17:34:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 17:34:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 17:34:59 INFO - Using env: {'DISPLAY': ':0', 17:34:59 INFO - 'HOME': '/home/cltbld', 17:34:59 INFO - 'LANG': 'en_US.UTF-8', 17:34:59 INFO - 'LANGUAGE': 'en_US:en', 17:34:59 INFO - 'LOGNAME': 'cltbld', 17:34:59 INFO - 'MAIL': '/var/mail/cltbld', 17:34:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:34:59 INFO - 'MOZ_NO_REMOTE': '1', 17:34:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:34:59 INFO - 'NO_EM_RESTART': '1', 17:34:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:34:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:34:59 INFO - 'PWD': '/builds/slave/test', 17:34:59 INFO - 'SHELL': '/bin/bash', 17:34:59 INFO - 'SHLVL': '1', 17:34:59 INFO - 'TERM': 'linux', 17:34:59 INFO - 'TMOUT': '86400', 17:34:59 INFO - 'USER': 'cltbld', 17:34:59 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1503362057.505580-1623270300', 17:34:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:34:59 INFO - '_': '/tools/buildbot/bin/python'} 17:34:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:34:59 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 17:34:59 INFO - Cleaning up... 17:34:59 INFO - Return code: 0 17:34:59 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:34:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:34:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:34:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:34:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:34:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x123f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x140aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15adf90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ab130>, '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 0x15ac030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15ac4c0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1503362057.505580-1623270300', '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 17:34:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 17:34:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 17:34:59 INFO - Using env: {'DISPLAY': ':0', 17:34:59 INFO - 'HOME': '/home/cltbld', 17:34:59 INFO - 'LANG': 'en_US.UTF-8', 17:34:59 INFO - 'LANGUAGE': 'en_US:en', 17:34:59 INFO - 'LOGNAME': 'cltbld', 17:34:59 INFO - 'MAIL': '/var/mail/cltbld', 17:34:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:34:59 INFO - 'MOZ_NO_REMOTE': '1', 17:34:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:34:59 INFO - 'NO_EM_RESTART': '1', 17:34:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:34:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:34:59 INFO - 'PWD': '/builds/slave/test', 17:34:59 INFO - 'SHELL': '/bin/bash', 17:34:59 INFO - 'SHLVL': '1', 17:34:59 INFO - 'TERM': 'linux', 17:34:59 INFO - 'TMOUT': '86400', 17:34:59 INFO - 'USER': 'cltbld', 17:34:59 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1503362057.505580-1623270300', 17:34:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:34:59 INFO - '_': '/tools/buildbot/bin/python'} 17:34:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:34:59 INFO - Downloading/unpacking blobuploader==1.2.4 17:34: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 17:34: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 17:34: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 17:34: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 17:35:00 INFO - Downloading blobuploader-1.2.4.tar.gz 17:35:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:35:00 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:35: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 17:35: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 17:35: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 17:35: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 17:35:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:35:01 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:35: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 17:35: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 17:35: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 17:35: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 17:35:01 INFO - Downloading docopt-0.6.1.tar.gz 17:35:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:35:01 INFO - Installing collected packages: blobuploader, requests, docopt 17:35:01 INFO - Running setup.py install for blobuploader 17:35:01 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:35:01 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:35:01 INFO - Running setup.py install for requests 17:35:01 INFO - Running setup.py install for docopt 17:35:01 INFO - Successfully installed blobuploader requests docopt 17:35:01 INFO - Cleaning up... 17:35:01 INFO - Return code: 0 17:35:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:35:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:35:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:35:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:35:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:35:01 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 0x123f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x140aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15adf90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ab130>, '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 0x15ac030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15ac4c0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1503362057.505580-1623270300', '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 17:35:01 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 17:35:01 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 17:35:01 INFO - Using env: {'DISPLAY': ':0', 17:35:01 INFO - 'HOME': '/home/cltbld', 17:35:01 INFO - 'LANG': 'en_US.UTF-8', 17:35:01 INFO - 'LANGUAGE': 'en_US:en', 17:35:01 INFO - 'LOGNAME': 'cltbld', 17:35:01 INFO - 'MAIL': '/var/mail/cltbld', 17:35:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:35:01 INFO - 'MOZ_NO_REMOTE': '1', 17:35:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:35:01 INFO - 'NO_EM_RESTART': '1', 17:35:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:35:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:35:01 INFO - 'PWD': '/builds/slave/test', 17:35:01 INFO - 'SHELL': '/bin/bash', 17:35:01 INFO - 'SHLVL': '1', 17:35:01 INFO - 'TERM': 'linux', 17:35:01 INFO - 'TMOUT': '86400', 17:35:01 INFO - 'USER': 'cltbld', 17:35:01 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1503362057.505580-1623270300', 17:35:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:35:01 INFO - '_': '/tools/buildbot/bin/python'} 17:35:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:35:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:35:02 INFO - Running setup.py (path:/tmp/pip-pLasTk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:35:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:35:02 INFO - Running setup.py (path:/tmp/pip-xfqTmL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:35:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:35:02 INFO - Running setup.py (path:/tmp/pip-onCOoY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:35:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:35:02 INFO - Running setup.py (path:/tmp/pip-LYMVmj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:35:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:35:02 INFO - Running setup.py (path:/tmp/pip-pV3c5z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:35:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:35:02 INFO - Running setup.py (path:/tmp/pip-vw49mM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:35:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:35:02 INFO - Running setup.py (path:/tmp/pip-IUjkz3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:35:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:35:02 INFO - Running setup.py (path:/tmp/pip-I2H1Mb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:35:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:35:02 INFO - Running setup.py (path:/tmp/pip-lvYOam-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:35:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:35:02 INFO - Running setup.py (path:/tmp/pip-jfEZ7W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:35:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:35:02 INFO - Running setup.py (path:/tmp/pip-c0Ib9S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:35:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:35:02 INFO - Running setup.py (path:/tmp/pip-NPo2Bf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:35:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:35:02 INFO - Running setup.py (path:/tmp/pip-Z_jKa_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:35:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:35:03 INFO - Running setup.py (path:/tmp/pip-o4i7uj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:35:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:35:03 INFO - Running setup.py (path:/tmp/pip-TM_2QI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:35:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:35:03 INFO - Running setup.py (path:/tmp/pip-AoKzb9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:35:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:35:03 INFO - Running setup.py (path:/tmp/pip-SkE37y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:35:03 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:35:03 INFO - Running setup.py install for manifestparser 17:35:03 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:35:03 INFO - Running setup.py install for mozcrash 17:35:03 INFO - Running setup.py install for mozdebug 17:35:03 INFO - Running setup.py install for mozdevice 17:35:03 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:35:03 INFO - Running setup.py install for mozfile 17:35:03 INFO - Running setup.py install for mozhttpd 17:35:03 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:35:03 INFO - Running setup.py install for mozinfo 17:35:03 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:35:03 INFO - Running setup.py install for mozInstall 17:35:04 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:35:04 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:35:04 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:35:04 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:35:04 INFO - Running setup.py install for mozleak 17:35:04 INFO - Running setup.py install for mozlog 17:35:04 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:35:04 INFO - Running setup.py install for moznetwork 17:35:04 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:35:04 INFO - Running setup.py install for mozprocess 17:35:04 INFO - Running setup.py install for mozprofile 17:35:04 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:35:04 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:35:04 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:35:04 INFO - Running setup.py install for mozrunner 17:35:04 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:35:04 INFO - Running setup.py install for mozscreenshot 17:35:04 INFO - Running setup.py install for moztest 17:35:04 INFO - Running setup.py install for mozversion 17:35:05 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:35:05 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:35:05 INFO - Cleaning up... 17:35:05 INFO - Return code: 0 17:35:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:35:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:35:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:35:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:35:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:35:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x123f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x140aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15adf90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ab130>, '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 0x15ac030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15ac4c0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1503362057.505580-1623270300', '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 17:35:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 17:35:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 17:35:05 INFO - Using env: {'DISPLAY': ':0', 17:35:05 INFO - 'HOME': '/home/cltbld', 17:35:05 INFO - 'LANG': 'en_US.UTF-8', 17:35:05 INFO - 'LANGUAGE': 'en_US:en', 17:35:05 INFO - 'LOGNAME': 'cltbld', 17:35:05 INFO - 'MAIL': '/var/mail/cltbld', 17:35:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:35:05 INFO - 'MOZ_NO_REMOTE': '1', 17:35:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:35:05 INFO - 'NO_EM_RESTART': '1', 17:35:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:35:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:35:05 INFO - 'PWD': '/builds/slave/test', 17:35:05 INFO - 'SHELL': '/bin/bash', 17:35:05 INFO - 'SHLVL': '1', 17:35:05 INFO - 'TERM': 'linux', 17:35:05 INFO - 'TMOUT': '86400', 17:35:05 INFO - 'USER': 'cltbld', 17:35:05 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1503362057.505580-1623270300', 17:35:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:35:05 INFO - '_': '/tools/buildbot/bin/python'} 17:35:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:35:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:35:05 INFO - Running setup.py (path:/tmp/pip-Muf2Qs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:35:05 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 17:35:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:35:05 INFO - Running setup.py (path:/tmp/pip-nPafY3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:35:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 17:35:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:35:05 INFO - Running setup.py (path:/tmp/pip-HekaUb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:35:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 17:35:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:35:05 INFO - Running setup.py (path:/tmp/pip-vlbiNI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:35:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.51 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:35:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:35:05 INFO - Running setup.py (path:/tmp/pip-sGPRfI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:35:05 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)) 17:35:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:35:05 INFO - Running setup.py (path:/tmp/pip-1ePAgC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:35:05 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)) 17:35:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:35:05 INFO - Running setup.py (path:/tmp/pip-RgjFbp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:35:05 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)) 17:35:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:35:05 INFO - Running setup.py (path:/tmp/pip-n3xbk_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:35:05 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)) 17:35:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:35:05 INFO - Running setup.py (path:/tmp/pip-wRdiWN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:35:05 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)) 17:35:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:35:05 INFO - Running setup.py (path:/tmp/pip-dhmFAo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:35:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.5 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:35:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:35:06 INFO - Running setup.py (path:/tmp/pip-S9Z1TJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:35:06 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 17:35:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:35:06 INFO - Running setup.py (path:/tmp/pip-Lkjinn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:35:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 17:35:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:35:06 INFO - Running setup.py (path:/tmp/pip-curpdZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:35:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 17:35:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:35:06 INFO - Running setup.py (path:/tmp/pip-ivFNHA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:35:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 17:35:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:35:06 INFO - Running setup.py (path:/tmp/pip-wMIqpm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:35:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 17:35:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:35:06 INFO - Running setup.py (path:/tmp/pip-lAoURV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:35:06 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 17:35:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:35:06 INFO - Running setup.py (path:/tmp/pip-7ntvZm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:35:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 17:35:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 17:35:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 17:35:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 17:35:06 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:35:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:35:06 INFO - Requirement already satisfied (use --upgrade to upgrade): requests in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozInstall==1.13->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 17:35:06 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:35:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:35:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:35:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:35:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:35:07 INFO - Downloading blessings-1.6.tar.gz 17:35:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:35:07 INFO - Installing collected packages: blessings 17:35:07 INFO - Running setup.py install for blessings 17:35:07 INFO - Successfully installed blessings 17:35:07 INFO - Cleaning up... 17:35:07 INFO - Return code: 0 17:35:07 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:35:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:35:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:35:08 INFO - Reading from file tmpfile_stdout 17:35:08 INFO - Current package versions: 17:35:08 INFO - argparse == 1.2.1 17:35:08 INFO - blessings == 1.6 17:35:08 INFO - blobuploader == 1.2.4 17:35:08 INFO - docopt == 0.6.1 17:35:08 INFO - functools32 == 3.2.3-2 17:35:08 INFO - jsonschema == 2.5.1 17:35:08 INFO - manifestparser == 1.1 17:35:08 INFO - mozInstall == 1.13 17:35:08 INFO - mozcrash == 1.0 17:35:08 INFO - mozdebug == 0.1 17:35:08 INFO - mozdevice == 0.51 17:35:08 INFO - mozfile == 1.2 17:35:08 INFO - mozhttpd == 0.7 17:35:08 INFO - mozinfo == 0.10 17:35:08 INFO - mozleak == 0.1 17:35:08 INFO - mozlog == 3.5 17:35:08 INFO - moznetwork == 0.27 17:35:08 INFO - mozprocess == 0.25 17:35:08 INFO - mozprofile == 0.28 17:35:08 INFO - mozrunner == 6.13 17:35:08 INFO - mozscreenshot == 0.1 17:35:08 INFO - mozsystemmonitor == 0.3 17:35:08 INFO - moztest == 0.8 17:35:08 INFO - mozversion == 1.4 17:35:08 INFO - psutil == 3.1.1 17:35:08 INFO - requests == 1.2.3 17:35:08 INFO - wsgiref == 0.1.2 17:35:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:35:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:35:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:35:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:35:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:35:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x123f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x140aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15adf90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ab130>, '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 0x15ac030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15ac4c0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1503362057.505580-1623270300', '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 17:35:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 17:35:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 17:35:08 INFO - Using env: {'DISPLAY': ':0', 17:35:08 INFO - 'HOME': '/home/cltbld', 17:35:08 INFO - 'LANG': 'en_US.UTF-8', 17:35:08 INFO - 'LANGUAGE': 'en_US:en', 17:35:08 INFO - 'LOGNAME': 'cltbld', 17:35:08 INFO - 'MAIL': '/var/mail/cltbld', 17:35:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:35:08 INFO - 'MOZ_NO_REMOTE': '1', 17:35:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:35:08 INFO - 'NO_EM_RESTART': '1', 17:35:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:35:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:35:08 INFO - 'PWD': '/builds/slave/test', 17:35:08 INFO - 'SHELL': '/bin/bash', 17:35:08 INFO - 'SHLVL': '1', 17:35:08 INFO - 'TERM': 'linux', 17:35:08 INFO - 'TMOUT': '86400', 17:35:08 INFO - 'USER': 'cltbld', 17:35:08 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1503362057.505580-1623270300', 17:35:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:35:08 INFO - '_': '/tools/buildbot/bin/python'} 17:35:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:35:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 17:35:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 17:35:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 17:35:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 17:35:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 17:35:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 17:35:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 17:35:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 17:35:08 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 17:35:08 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 17:35:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:35:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:35:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:35:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:35:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 17:35:09 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)) 17:35:09 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)) 17:35:09 INFO - Installing collected packages: simplejson 17:35:09 INFO - Running setup.py install for simplejson 17:35:09 INFO - building 'simplejson._speedups' extension 17:35:09 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 17:35:10 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 17:35:10 INFO - Successfully installed simplejson 17:35:10 INFO - Cleaning up... 17:35:10 INFO - Return code: 0 17:35:10 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:35:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:35:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:35:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:35:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:35:10 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 0x123f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x140aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15adf90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ab130>, '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 0x15ac030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15ac4c0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1503362057.505580-1623270300', '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 17:35:10 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 17:35:10 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 17:35:10 INFO - Using env: {'DISPLAY': ':0', 17:35:10 INFO - 'HOME': '/home/cltbld', 17:35:10 INFO - 'LANG': 'en_US.UTF-8', 17:35:10 INFO - 'LANGUAGE': 'en_US:en', 17:35:10 INFO - 'LOGNAME': 'cltbld', 17:35:10 INFO - 'MAIL': '/var/mail/cltbld', 17:35:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:35:10 INFO - 'MOZ_NO_REMOTE': '1', 17:35:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:35:10 INFO - 'NO_EM_RESTART': '1', 17:35:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:35:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:35:10 INFO - 'PWD': '/builds/slave/test', 17:35:10 INFO - 'SHELL': '/bin/bash', 17:35:10 INFO - 'SHLVL': '1', 17:35:10 INFO - 'TERM': 'linux', 17:35:10 INFO - 'TMOUT': '86400', 17:35:10 INFO - 'USER': 'cltbld', 17:35:10 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1503362057.505580-1623270300', 17:35:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:35:10 INFO - '_': '/tools/buildbot/bin/python'} 17:35:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:35:10 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 17:35:10 INFO - Cleaning up... 17:35:10 INFO - Return code: 0 17:35:10 INFO - Running post-action listener: _resource_record_post_action 17:35:10 INFO - Running post-action listener: _start_resource_monitoring 17:35:10 INFO - Starting resource monitoring. 17:35:10 INFO - [mozharness: 2017-08-22 00:35:10.786697Z] Finished create-virtualenv step (success) 17:35:10 INFO - [mozharness: 2017-08-22 00:35:10.787214Z] Running install step. 17:35:10 INFO - Running pre-action listener: _resource_record_pre_action 17:35:10 INFO - Running main action method: install 17:35:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:35:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:35:11 INFO - Reading from file tmpfile_stdout 17:35:11 INFO - Detecting whether we're running mozinstall >=1.0... 17:35:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:35:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:35:11 INFO - Reading from file tmpfile_stdout 17:35:11 INFO - Output received: 17:35:11 INFO - Usage: mozinstall [options] installer 17:35:11 INFO - Options: 17:35:11 INFO - -h, --help show this help message and exit 17:35:11 INFO - -d DEST, --destination=DEST 17:35:11 INFO - Directory to install application into. [default: 17:35:11 INFO - "/builds/slave/test"] 17:35:11 INFO - --app=APP Application being installed. [default: firefox] 17:35:11 INFO - mkdir: /builds/slave/test/build/application 17:35:11 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'] 17:35:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 17:35:29 INFO - Reading from file tmpfile_stdout 17:35:29 INFO - Output received: 17:35:29 INFO - /builds/slave/test/build/application/firefox/firefox 17:35:29 INFO - Running post-action listener: _resource_record_post_action 17:35:29 INFO - [mozharness: 2017-08-22 00:35:29.180373Z] Finished install step (success) 17:35:29 INFO - [mozharness: 2017-08-22 00:35:29.180654Z] Running setup-mitmproxy step. 17:35:29 INFO - Running pre-action listener: _resource_record_pre_action 17:35:29 INFO - Running main action method: setup_mitmproxy 17:35:29 INFO - Skipping: mitmproxy is not required 17:35:29 INFO - Running post-action listener: _resource_record_post_action 17:35:29 INFO - [mozharness: 2017-08-22 00:35:29.181864Z] Finished setup-mitmproxy step (success) 17:35:29 INFO - [mozharness: 2017-08-22 00:35:29.182086Z] Running run-tests step. 17:35:29 INFO - Running pre-action listener: _resource_record_pre_action 17:35:29 INFO - Running pre-action listener: _set_gcov_prefix 17:35:29 INFO - Running main action method: run_tests 17:35:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:35:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:35:29 INFO - Python 2.7.3 17:35:29 INFO - Return code: 0 17:35:29 INFO - grabbing minidump binary from tooltool 17:35:29 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')]} 17:35:29 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 0x15ab130>, '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 0x15ac030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15ac4c0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:35:29 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 17:35:29 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 17:35:29 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 17:35:29 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:35:29 INFO - Return code: 0 17:35:29 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 17:35:29 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:35:29 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:35:29 INFO - ENV: RUST_BACKTRACE is now full 17:35:29 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 17:35:29 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:35:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/FkdMd0HTQmiwzY-YzIEfag/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-004', '--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 17:35:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/FkdMd0HTQmiwzY-YzIEfag/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-004 --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 17:35:29 INFO - Using env: {'DISPLAY': ':0', 17:35:29 INFO - 'HOME': '/home/cltbld', 17:35:29 INFO - 'LANG': 'en_US.UTF-8', 17:35:29 INFO - 'LANGUAGE': 'en_US:en', 17:35:29 INFO - 'LOGNAME': 'cltbld', 17:35:29 INFO - 'MAIL': '/var/mail/cltbld', 17:35:29 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:35:29 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:35:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:35:29 INFO - 'MOZ_NO_REMOTE': '1', 17:35:29 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:35:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:35:29 INFO - 'NO_EM_RESTART': '1', 17:35:29 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:35:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:35:29 INFO - 'PWD': '/builds/slave/test', 17:35:29 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:35:29 INFO - 'RUST_BACKTRACE': 'full', 17:35:29 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 17:35:29 INFO - 'SHELL': '/bin/bash', 17:35:29 INFO - 'SHLVL': '1', 17:35:29 INFO - 'STYLO_FORCE_ENABLED': '1', 17:35:29 INFO - 'TERM': 'linux', 17:35:29 INFO - 'TMOUT': '86400', 17:35:29 INFO - 'USER': 'cltbld', 17:35:29 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1503362057.505580-1623270300', 17:35:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:35:29 INFO - '_': '/tools/buildbot/bin/python'} 17:35:29 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/FkdMd0HTQmiwzY-YzIEfag/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-004', '--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 17:35:29 INFO - mozversion application_buildid: 20170821234030 17:35:29 INFO - mozversion application_changeset: 128a79130ecd6f277190d031a623f991c73c5272 17:35:29 INFO - mozversion application_display_name: Nightly 17:35:29 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:35:29 INFO - mozversion application_name: Firefox 17:35:29 INFO - mozversion application_remotingname: firefox 17:35:29 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 17:35:29 INFO - mozversion application_vendor: Mozilla 17:35:29 INFO - mozversion application_version: 57.0a1 17:35:29 INFO - mozversion platform_buildid: 20170821234030 17:35:29 INFO - mozversion platform_changeset: 128a79130ecd6f277190d031a623f991c73c5272 17:35:29 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 17:35:29 INFO - mozversion platform_version: 57.0a1 17:35:29 INFO - using testdate: 1503362129 17:35:29 INFO - actual date: 1503362129 17:35:29 INFO - starting webserver on 'localhost:33683' 17:35:29 INFO - SUITE-START | Running 2 tests 17:35:29 INFO - TEST-START | dromaeo_css 17:35:29 INFO - Initialising browser for dromaeo_css test... 17:35:29 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:33683/getInfo.html -profile /tmp/tmpT2RJW2/profile 17:35:29 INFO - TEST-INFO | started process 23082 (/builds/slave/test/build/application/firefox/firefox http://localhost:33683/getInfo.html) 17:35:35 INFO - TEST-INFO | 23082: exit 0 17:35:35 INFO - Browser initialized. 17:35:35 INFO - Running cycle 1/1 for dromaeo_css test... 17:35:35 INFO - TEST-INFO | started process 23316 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpT2RJW2/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 17:35:36 INFO - PID 23316 | 17:35:36 INFO - PID 23316 | (/builds/slave/test/build/application/firefox/firefox:23367): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 17:35:36 INFO - PID 23316 | 17:35:37 INFO - PID 23316 | 17:35:37 INFO - PID 23316 | (/builds/slave/test/build/application/firefox/firefox:23428): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 17:35:37 INFO - PID 23316 | 17:35:37 INFO - PID 23316 | __metrics Screen width/height:1600/1200 17:35:37 INFO - PID 23316 | colorDepth:24 17:35:37 INFO - PID 23316 | Browser inner width/height: 1024/768 17:35:37 INFO - PID 23316 | __metrics 17:35:47 INFO - PID 23316 | RSS: Main: 174850048 17:35:47 INFO - PID 23316 | 17:38:44 INFO - PID 23316 | Cycle 1(1): loaded http://localhost:33683/tests/dromaeo/cssquery-dojo.html (next: http://localhost:33683/tests/dromaeo/cssquery-ext.html) 17:38:46 INFO - PID 23316 | RSS: Main: 178204672 17:38:46 INFO - PID 23316 | 17:41:48 INFO - PID 23316 | Cycle 1(1): loaded http://localhost:33683/tests/dromaeo/cssquery-ext.html (next: http://localhost:33683/tests/dromaeo/cssquery-jquery.html) 17:41:48 INFO - PID 23316 | RSS: Main: 175190016 17:41:48 INFO - PID 23316 | 17:44:50 INFO - PID 23316 | Cycle 1(1): loaded http://localhost:33683/tests/dromaeo/cssquery-jquery.html (next: http://localhost:33683/tests/dromaeo/cssquery-mootools.html) 17:44:51 INFO - PID 23316 | RSS: Main: 177336320 17:44:51 INFO - PID 23316 | 17:47:52 INFO - PID 23316 | Cycle 1(1): loaded http://localhost:33683/tests/dromaeo/cssquery-mootools.html (next: http://localhost:33683/tests/dromaeo/cssquery-prototype.html) 17:47:53 INFO - PID 23316 | RSS: Main: 175464448 17:47:53 INFO - PID 23316 | 17:50:57 INFO - PID 23316 | Cycle 1(1): loaded http://localhost:33683/tests/dromaeo/cssquery-prototype.html (next: http://localhost:33683/tests/dromaeo/cssquery-yui.html) 17:50:57 INFO - PID 23316 | RSS: Main: 179027968 17:50:57 INFO - PID 23316 | 17:53:59 INFO - PID 23316 | Cycle 1(1): loaded http://localhost:33683/tests/dromaeo/cssquery-yui.html (next: http://localhost:33683/tests/dromaeo/cssquery-dojo.html) 17:53:59 INFO - PID 23316 | RSS: Main: 178032640 17:53:59 INFO - PID 23316 | 17:53:59 INFO - PID 23316 | __start_tp_report 17:53:59 INFO - PID 23316 | _x_x_mozilla_page_load 17:53:59 INFO - PID 23316 | _x_x_mozilla_page_load_details 17:53:59 INFO - PID 23316 | |i|pagename|runs| 17:53:59 INFO - PID 23316 | |0;dojo.html;3098.6436559795616;3122.750179985601;3123.6251649802025;3152.558641790149;3161.8419079046043;6070.635761854286;6236.501079913607;6243.375662433755;6262.0919966604815;6283.151774510446;6092.421219984094;6192.1021451889565;6199.473044791198;6216.129741836146;6242.906356404646;5648.124540696178;5650.830475085733;5666;5707.857303567403;5724.570657200706;5750.424957504258;5758.510526605243;5759.1361295805755;5760.798372056979;5770.884582308351;143.6669262680065;5556.277683901067;5670.432956704338;5767.711614419283;5798.246227990356;5578.9163162552595;5583.469570390847;5609.102543593046;5682.54539636828;5712.714364281769;5569.443055694439;5576.6375185613215;5635.1828984797385;5649.435056494359;5651.7739290428335;6053.122297266916;6080.574359794772;6087.573869829113;6143.631382117042;6173.135760993465;6584.440322572587;6643.534952553323;6655.500837437163;6681.498887583402;6708;6566.376194261537;6696.7656132035145;6704.966475167642;6759.121314229119;6793.626350550767;6162.1681073055015;6206.193194884681;6240.219972503437;6244.93836047873;6247.281562620311;6841.3842754152365;6869.622170780655;6925.307469253135;6932.549384290005;6945.583265004116;6526.510511711545;6540.4767618590395;6599.1091202687985;6610.7025183866845;6634.336566343423;6542.116814230113;6620.271770105284;6638.535302528777;6644.235912870082;6717.328267173243;6618.602883826986;6662.600243985376;6668.166479190101;6685.0640910272605;6719.664016799141;6656.101426307387;6713.765018224436;6715.832104197434;6727.93272067273;6742.76400325996;5256.894862102737;5266.605004624668;5320.946790532123;5388.946110538923;5398.757055932492;4538.455385353779;4559.361689363425;4563.9087218255445;4572.4055872736335;4602.953970460319;5703;5775.768969241268;5818.272715910512;5826.475617194473;5836.766529338864;6558.147440832661;6626.966865165643;6703.396694297439;6728.394444500019;6738.59568425896;5759.280089988752;5766.365699773021;5831.504322132581;5836.358000619928;5845.327787304429;5755.050416681284;5807.419258074159;5867.70661466925;5892.027815410495;5894.292684877756;6447.838804029937;6470.255920569195;6470.45001174896;6489.610623362613;6559;6676.432503237182;6676.83307917306;6751.831204219934;6773.390394864486;6778.051072849904;6434.678266086583;6460.709268083042;6480.384363485461;6536.215654121535;6566.737330506918;6457.741690332522;6533.67331633407;6541.574797638138;6542.803715888531;6549.24683661366;6563;6582.506312026521;6634.270230274569;6651.46788256948;6652.534322597372;6319.96840015797;6339.175907132043;6366.267879193767;6414.647194404166;6434.549581529248;6387.297397286387;6387.712552935036;6418.133551970424;6425.453836423956;6438.163038804925;6243.656598887105;6267.780627678009;6311.084892690626;6398.648074355955;6413.230412350361;6407.423331900151;6463.224413070461;6465.903011454926;6496.6751662415745;6571.441427478527;6189.164462797465;6255.9374406257175;6320.209973753281;6351.301356850835;6357.523185760994 17:53:59 INFO - PID 23316 | |1;ext.html;828.304224451461;877.4647465046321;890.6214858685057;901.0358915959921;1181.539199712113;32268;32776.67223327766;43572.346414803804;44192.779036104774;44423.555764442346;44405.555944440544;44827.32759008609;44932.775336123355;44934.32598511017;44964.100717985624;6546.9017964730565;7862.095858976205;7963.124056353797;7978.880316795253;8036.758897233063;7866.685332586719;7890.8816367754525;7971.760847174565;7975.361971042303;7979.760607181794;8006.119326874039;8070.233327833876;8071.919280807205;8075.030996280425;8075.5154690718455;7975.082865470487;7985.640646170937;8015.519068855887;8019.639116239783;8034.397420193509;7871.330936870316;7916.485428447132;7917.168697286817;7922.168172341936;7923.247291507298;40387.7980610098;40724.38913416301;40735.796321018504;40744;40745;3558.857645694169;3601.1897323102353;3620.7646502977223;3628.5101511296166;3631.1285291530107;31810;31854;31944.680553194634;32068.358632827214;32130;4871.12319782439;5132.871678208075;5151.5878729701535;5175.45657705943;5181.844544663666;177091;177221.99999999872;177718;177960;178017;49481.752591236815;50025.24962125571;51577;51846.74076629593;51847.48152518502;54109.72945135249;54462.45537544574;54694.726526367114;54696;54778;16500.917495412687;16729.49811505657;16824.074675892698;16872.325106995828;16974.83025169757;13629.591112266648;13698.52055178064;13701.794473082911;13730.244836534086;13730.65673358174;14802;14916.328765205591;14918;14942;15057.397704091714;5860.355360910296;5872.706364681749;5878.118282257696;5972.163897054415;5975.701214939236;975.5853762151057;983.5868935047297;983.6606370802061;994.4083270454068;1022.7801022780138;23145.749471922216;23149.537009259722;23219.419514511934;23551.41121471977;23754.524909501713;1106.0764261841452;1113.7995160871121;1124.6738445850776;1128.9379084150287;1129.175701737736;12315.75368492643;12403.193792403465;12410.627681169399;12502.437390317458;12504.499820007099;238845;239399;239711;240699;240986;54507.72746136323;54662;54736.17895731567;54754.45245547573;54831;1440.3662388549005;1446.428660679047;1490.411287541415;1492.5373134328393;1497.3636204612997;22555.887220563793;22815.771842281363;22853;22919.656205156603;22986.885065574566;38720.2255954885;38789;38789.6121038786;38801.61198388093;38855.6114438852;208805;214869;215066;215399;215585;37908.81045594755;37952.62047379491;37998.62001379951;38296.808515957244;38369.4244586337;47831;48226;48304.7584762074;48386.75806620944;48388;34602.48096278608;34667.826660866536;34776.82611587027;35597.28805423929;35764.46353304754;34011.31977360389;34398.312033759685;34741;34810.30379392347;34953.12617184489;37759.62240377671;39737.2052558953;40061.198776024896;40070.19859602733;40139.39790903197;34229;34424;34760;34797.652023480456;35092.82453587716;24541.75458245395;24576.38559035967;24640.630390544517;24734.505309894063;24924.003039878928 17:53:59 INFO - PID 23316 | |2;jquery.html;581.1660267516115;581.7818318130703;587.1926101610286;590.6220019187718;602.8643555200081;22922.426939326506;23814;23848.761512384892;23883;23884.76115238847;21159.471013224676;24270.514589708197;24739.628905566387;26892.865535672343;26956.191314260555;6499.675016249181;6659.533832631718;6660.533762636617;6665.133532640774;6668.666566671672;6194.946859033953;6519.185101862267;6563.1796025496815;6564.474842012652;6576.901346479783;6436.871262574746;6438.356164383547;6460.612363258196;6460.967695161541;6470.644114573696;6435.195600549931;6436.839079023015;6453.064305675674;6459.709313080899;6461.224653041641;5993.490553302974;5999.310079340888;6003.129546215818;6003.369646187175;6015.849603759941;29419.558706619417;30239.848800755855;30529.08412747621;30667.539986900214;30775.38449231025;1942.5726340205274;1994.1425187169511;1994.5013746563359;1995.2318357432348;1997.8601497895154;19146;19636.70544941827;19657.115429805694;19790.406287811387;19841.305554305673;2386.4033991502124;2420.261820144855;2472.876356182184;2527.36815796051;2530;120531.3973430136;128853;138974;140860.29569852186;147805.26097369552;14723.705525889422;15000.024998375071;15004.874634402464;15262.694746105015;15713;23676.408089797547;23697;23793.52412951731;23812;23868.761312387;10602.469876506144;10610.416427096583;10624.653234231193;10675.092617127475;10745.892541074489;9875.160611347972;9896.416573348373;9969.950150249348;9979.301448898508;10025.598976041023;9378.155965963097;9583.520823958774;9587.952060239653;9612.18296444796;9685.612575497042;2664.653595032672;2718.143784707811;2744.7118052604587;2771.418002219516;2786.5820126981116;950.5817440326234;968.9031096890395;971.3443425687774;977.8386566216494;981.9950900245595;19090.427287181406;19932.800671993093;20088.09603567843;20115.798842011685;24092.15677451281;1017.6590842067842;1035.1304903880775;1045.210865796319;1060.9522571484301;1064.5794911010262;11085.445727713743;11366.09071274296;11379.032782213604;11381.374024428736;11545.307281563133;482846;501753;514205;514813;516177;120102.399488002;124966;126297;126436;127530.36234818767;1243.564752336675;1279.270815635079;1292.5799115287568;1304.7716649586284;1310.593715948059;21069.683954740998;21197.894010530465;21582.6762598558;21594.352169434944;21602.783972160076;58710.70644646749;60244.39755602563;60726.39273607208;62127.37872621216;62329.688351557954;70484.29515704777;75683;78846;79926;80039.59980200062;14595.85404145945;15113.244337783286;15219.847801522286;15253.847461525243;15289.541313760605;23845.165419210243;24032.51934961326;24039;24138.51722965566;24419.511609768062;18823.964681942078;18967.620647587246;19044.238230470626;19286.71069933924;19320.8067919319;16833.41083062087;17262.136893155544;17591.648167036845;17734.20196091153;17875.553111172325;18544.629107417506;19864.90067549711;19882.90058549698;19899.403017909484;20181;14750.55748327552;15061.849381506045;15071.321790519234;15079.64283214516;15112.924435377752;18616.906915465337;18712.25150993945;18717.71923421177;18773.06134693287;18844.246230151188 17:53:59 INFO - PID 23316 | |3;mootools.html;1371.6570857285676;1417.5818133650575;1418.1987177244855;1432.1979691372826;1432.2838580709638;13723.931380343096;13959.651008724786;14312.570622881318;14313.642158946019;14336.354864031118;14350.067245629027;14471.493497727583;14548.636284092903;14560.781588276184;14636;2685.04680838302;2748.8213266137636;2751.2296556964084;2751.862406879648;2752.628395166657;2469.2098528470897;2705.147878418292;2750.3124218945263;2756.145594865588;2757.600147978542;2639.313778417606;2664.9333766655795;2670.305720512661;2690.9596356054676;2698.689650690176;2572.8199026068182;2577.90977315794;2606.1399738086384;2607.1005503101496;2608.282722251377;2551.6810398700163;2574.266334094793;2579.587266037444;2582.690077190749;2585.482903419305;13311.467541298336;13626.454941802316;13635.113717608323;13650.112742671694;13655.726885462234;7412.666430010609;7654.923450765533;7660.770176894702;7672.693092276302;7676.11724651661;4958.479359667219;5109.3613298337705;5190.429052804188;5277.313949186581;5282.947170528284;1813.3925135079633;1839.8160183981495;1854.378783107647;1880.5862710203733;1883.858710596697;22260.777392226195;22718;22732.999999999836;22747.658785118238;22793.886030569905;6730.966345168341;6737.225219099866;6837.794866154023;6959.930400695928;7007.4394048476;17919.46241612754;17933.461996140137;17965.101744912703;17978.55053623644;18021.369252076114;7637.42719296055;7918.445708800328;7936.841263174704;7954.443188976716;7957.721479748181;6140.078988151724;6321;7022.40309573692;7118.715251389886;7124.073870396919;5554.666719996813;5563.5271001964475;5606.887862242732;5651.2935883014625;5665.206871038058;1702.4467048209133;1704.548294701905;1720.380662961333;1739.1391261325725;1744.5376975101608;889.8798662180652;902.4044130873592;906.4968942237122;916.2807196350833;919.2554031234721;7213.278672132745;7275.599842008741;7285.708571657075;7292.088488938883;7402.185759566443;725.361681720083;727.3962611032936;730.1639622632057;736.6353654940839;738.4129616954534;4605.539446055434;4996.625253105959;5204;5217.634765566374;5280.841574752763;18561;19145.521361965784;19198.712019319722;19291.80708192928;19301;18720.438386848415;18768.71846922297;18820.05899705009;18827;19051.523711907037;10578.471076446147;10735.89264107349;10820.13438924884;10828.512716927757;10848.566057357617;8213.3429325655;8416.284615807725;8523.95738021306;8539.402241843012;8585.613647386008;16479.588010299358;16657.416990405276;16745.413910513074;16879.74680379771;16918.238679259215;16766.161691915113;16885.662286754443;17035.48893533196;17072.658546829243;17130.030046544307;10202.744931376776;10653.254272200871;10693;10702;10769.515371808444;13203;13424.39590218423;13427;13431.19412835233;13439.126456780277;10437.373757574569;10605.151587873106;10629.36223826542;10694.41180735067;10840.67477975662;10650.8934910653;10800.24398292112;10870.945645272039;10938.343699378063;11080.390578517936;9446.480443575669;9627.614895404105;9638.566264518253;9661.613535458784;9679.66121185755;7362.595057271901;7443.665035073326;7462.029936108272;7486.6256687166515;7518.360939320219;7172.641367931687;7249.673764680497;7272.563646181246;7297.160826504807;7359.77920662381 17:53:59 INFO - PID 23316 | |4;prototype.html;499.53199187169315;504.3267238236955;519.3300642171599;522.850987468571;535.4484880573009;6249.218847644039;6259;6259.968700156504;6269.153664255324;6282;6179.907301390472;6189.4738947189435;6204.41058099481;6209.937900620993;6210.9689451552795;5087.135187018197;5105.310783044297;5136.04830164537;5144;5151.793928242866;4790.736509491977;4992.326035985132;5129.846104616849;5133.589312854962;5135.666181698178;4854.781534830941;4868;4892.6575139740235;4909.45995940448;4909.680870743408;4862.513748625144;4865.513448655124;4872.537108974641;4896.559309662148;4956.826511072095;4305.268104422255;4400.3399490076745;4400.515943246241;4431.490378606437;4436.245838207513;5876.7355469004;5925.4370834770625;5946.583739138262;5948.226730525047;5988.940110598882;5576.888462230732;5577.6653400796085;5630;5672.716364181774;5697.259356283698;6429.132067170919;6439.8068057958335;6485.254195767453;6490.318516555741;6513.088167656532;4808.278758186265;4833.806647734086;4838.903221935541;4847.466778654345;4853.514648535153;6570;6650.301718319603;6660.167479065165;6729.495287853381;6753;4934.481879402611;4952.702837829742;4967.205247160437;4977.1538838397555;4991.35285355839;5065.518775716301;5066.417362003343;5083.771230294646;5083.8983220335385;5092.312537807423;5605.411431799684;5617;5623.775048997994;5632.464915832989;5635.943640563624;6535.758205940856;6564.540482166298;6566.8179727649485;6596.472282217411;6603.471722262208;1762.8237176282269;1768.6993211154136;1769;1769.9469015929285;1774.3612299572144;1174.5888938871497;1218.8110842819376;1222.3216115056052;1222.81657751338;1241.0815996162773;5699.572532060112;5792.681402522901;5797.855053623609;5826;5839.270091238595;6683.498737594603;6729.764458243938;6789.660516974231;6799.218089919624;6818.659067046727;5683.8010669626365;5735.627184233012;5748.655080695172;5754.482096611241;5833.125031245348;3526.5768107827225;3534.0811389039036;3567.518385017989;3573.874914377984;3601.38776408006;6400.487960963112;6434.067060276234;6511.446527045159;6532.412082912466;6587.110740050128;6737.225219099768;6813.965930170318;6872.934695122264;6878.931210687829;6895.689693963784;6366.681665916593;6442.387973142544;6459.224893012869;6469.902951455732;6584.308647591934;6273.278572964167;6636.5686230396805;6674.332566743286;6694.096296999843;6777.728890844311;6528.771492997722;6537.934620653733;6540.117084193763;6614.536982411378;6687.164104486939;6294.181756371642;6363.300036996019;6443.7744678936015;6463.192100987377;6476.384743449365;4912.82805101834;4925.926111108264;4948.950510494849;4996.15065438869;5021.347224860745;6452.54832161763;6558.934410655832;6620.139381880324;6697.631630260187;6737.393634572912;6405.839854003687;6429.6142231466265;6469.76793006412;6483.546151769519;6543.967280163569;6417.97312430009;6463.903041454476;6482.902756458562;6493.805185844432;6504.772332968323;6295.811125666238;6329;6381.489480841615;6389.648569328731;6411.6153030818305;6427.742890284523;6429.646369449538;6458.220916521834;6488.448481878904;6534.379233972765;6260.968695156495;6326.462250708557;6328.525360598066;6334.398232167937;6360.618362898241 17:53:59 INFO - PID 23316 | |5;yui.html;874.2918236228655;890.2210565754964;901.9413738107019;903.9276857851372;904.9502277374742;18579.163937622805;19550.706739398902;19573.923434211112;19592.90203548982;21890.452738681543;21747.456313592167;22090.668639970412;22350.888245558748;22365.888170559123;22383.888080559573;978.9363691360056;1013.7719013222003;1017.1405162637559;1017.1913328903539;1017.4658304390181;997.5411310797042;1031.097789434245;1067.9733006674855;1068.2735739697002;1069.6149386220955;1117.5306371324064;1125.4766533561892;1126.2904370246774;1128.4075860173434;1139.1570238023844;1120.2886167283752;1123.960661376856;1125.482278152051;1127.503898284752;1127.7349822791637;825.8926339575877;826.7891687619679;827.1067247372823;827.9337652987747;828.1180542722042;18442.446726598224;18637.7204341935;20387.89806050975;20579.794202057936;20586.5882682347;22061.227857024925;22105.66841497379;22308;22345;22596.096156153733;16174.838251617452;16375.344986200538;16432.78157448741;16569;16654.417095401725;3640.21735326906;3672.485851980725;3673.5775385830702;3683.778973261613;3687.483752274684;125312;126372.36813815964;127121;129609.99999999905;130245.34877325647;16728.912620679617;17262.136893155544;17368.82631173672;17421.39025134114;17784.99999999974;31943.520847187312;32182.35635287328;32265;32650.18374540608;32679.836600817318;8066.959665201636;8408.32733381328;8752.168543988311;9055.773605659911;9306.208972237435;4218.219629368516;4270.914581708348;4278.422412974271;4294.3558466230315;4315.266404711144;4901.803927842846;4975.651704380731;4984.501549845059;5032.270320803463;5056.519630635084;1003.6988903328972;1034.6844212515255;1039.0752230514847;1040.1262939131166;1043.6503771236721;613.9355367686329;621.2234706616729;625.4902254662436;626.7680958045553;647.915770949783;11739.647810565697;12025.158238923192;12403.317817520123;12674.746505069847;13046.673833154247;586.5688718791685;624.7313655128247;632.8291361332415;638.2755572425331;646.0567571345888;5324.5740340772645;5556.72216389187;5613.326400831927;5747.109198074305;5806.129080637938;104273;107258;108082.45958770155;109684.4515777432;111749;93646;94073.52963235277;94178.52910735403;96068;96599.51700241453;86423;86471.56764216139;87930;89788.5510572443;90071;10666.093382062301;10872.728181795519;11087.113030957666;11123;11221.887781122085;37858.24283514369;38486.23027539378;38799;38920;40292.992675183355;49401.50598493969;49680.75159624179;50276.245856311456;50466;51364.74317628388;13979.720405592034;16545;16981.320747169975;17064.402745903833;17080.402185923434;22158.77841221567;22215.88892055594;22770.886145569166;22867.771322286564;22875.88562057179;18518.16668249959;19093.90453047726;19561.21755129779;19698.50753731168;20325.983700814606;17372;17996;18013.819861801738;18373.356932507297;18512.44462666122;18643.347482838035;18767.718484222474;19050.333238336592;19102.426927192206;19315.8068419314;13529;13729.725405492034;13758.243296618783;13986.370613322222;14128.152310861382;12628.810567841307;12953.611391658265;13263.2705201211;13776.173429594257;14746.852531474977 17:53:59 INFO - PID 23316 | __end_tp_report 17:53:59 INFO - PID 23316 | __start_cc_report 17:53:59 INFO - PID 23316 | _x_x_mozilla_cycle_collect,385 17:53:59 INFO - PID 23316 | __end_cc_report 17:53:59 INFO - PID 23316 | __startTimestamp1503363239914__endTimestamp 17:53:59 INFO - PID 23316 | 17:53:59 INFO - PID 23316 | ------- Summary: start ------- 17:53:59 INFO - PID 23316 | Number of tests: 6 17:53:59 INFO - PID 23316 | 17:53:59 INFO - PID 23316 | [#0] dojo.html Cycles:165 Average:6083.50 Median:6339.18 stddev:864.20 (13.6%) stddev-sans-first:834.53 17:53:59 INFO - PID 23316 | Values: 3098.6 3122.8 3123.6 3152.6 3161.8 6070.6 6236.5 6243.4 6262.1 6283.2 6092.4 6192.1 6199.5 6216.1 6242.9 5648.1 5650.8 5666.0 5707.9 5724.6 5750.4 5758.5 5759.1 5760.8 5770.9 143.7 5556.3 5670.4 5767.7 5798.2 5578.9 5583.5 5609.1 5682.5 5712.7 5569.4 5576.6 5635.2 5649.4 5651.8 6053.1 6080.6 6087.6 6143.6 6173.1 6584.4 6643.5 6655.5 6681.5 6708.0 6566.4 6696.8 6705.0 6759.1 6793.6 6162.2 6206.2 6240.2 6244.9 6247.3 6841.4 6869.6 6925.3 6932.5 6945.6 6526.5 6540.5 6599.1 6610.7 6634.3 6542.1 6620.3 6638.5 6644.2 6717.3 6618.6 6662.6 6668.2 6685.1 6719.7 6656.1 6713.8 6715.8 6727.9 6742.8 5256.9 5266.6 5320.9 5388.9 5398.8 4538.5 4559.4 4563.9 4572.4 4603.0 5703.0 5775.8 5818.3 5826.5 5836.8 6558.1 6627.0 6703.4 6728.4 6738.6 5759.3 5766.4 5831.5 5836.4 5845.3 5755.1 5807.4 5867.7 5892.0 5894.3 6447.8 6470.3 6470.5 6489.6 6559.0 6676.4 6676.8 6751.8 6773.4 6778.1 6434.7 6460.7 6480.4 6536.2 6566.7 6457.7 6533.7 6541.6 6542.8 6549.2 6563.0 6582.5 6634.3 6651.5 6652.5 6320.0 6339.2 6366.3 6414.6 6434.5 6387.3 6387.7 6418.1 6425.5 6438.2 6243.7 6267.8 6311.1 6398.6 6413.2 6407.4 6463.2 6465.9 6496.7 6571.4 6189.2 6255.9 6320.2 6351.3 6357.5 17:53:59 INFO - PID 23316 | 17:53:59 INFO - PID 23316 | [#1] ext.html Cycles:180 Average:39028.02 Median:37930.72 stddev:54996.74 (145.0%) stddev-sans-first:55076.22 17:53:59 INFO - PID 23316 | Values: 828.3 877.5 890.6 901.0 1181.5 32268.0 32776.7 43572.3 44192.8 44423.6 44405.6 44827.3 44932.8 44934.3 44964.1 6546.9 7862.1 7963.1 7978.9 8036.8 7866.7 7890.9 7971.8 7975.4 7979.8 8006.1 8070.2 8071.9 8075.0 8075.5 7975.1 7985.6 8015.5 8019.6 8034.4 7871.3 7916.5 7917.2 7922.2 7923.2 40387.8 40724.4 40735.8 40744.0 40745.0 3558.9 3601.2 3620.8 3628.5 3631.1 31810.0 31854.0 31944.7 32068.4 32130.0 4871.1 5132.9 5151.6 5175.5 5181.8 177091.0 177222.0 177718.0 177960.0 178017.0 49481.8 50025.2 51577.0 51846.7 51847.5 54109.7 54462.5 54694.7 54696.0 54778.0 16500.9 16729.5 16824.1 16872.3 16974.8 13629.6 13698.5 13701.8 13730.2 13730.7 14802.0 14916.3 14918.0 14942.0 15057.4 5860.4 5872.7 5878.1 5972.2 5975.7 975.6 983.6 983.7 994.4 1022.8 23145.7 23149.5 23219.4 23551.4 23754.5 1106.1 1113.8 1124.7 1128.9 1129.2 12315.8 12403.2 12410.6 12502.4 12504.5 238845.0 239399.0 239711.0 240699.0 240986.0 54507.7 54662.0 54736.2 54754.5 54831.0 1440.4 1446.4 1490.4 1492.5 1497.4 22555.9 22815.8 22853.0 22919.7 22986.9 38720.2 38789.0 38789.6 38801.6 38855.6 208805.0 214869.0 215066.0 215399.0 215585.0 37908.8 37952.6 37998.6 38296.8 38369.4 47831.0 48226.0 48304.8 48386.8 48388.0 34602.5 34667.8 34776.8 35597.3 35764.5 34011.3 34398.3 34741.0 34810.3 34953.1 37759.6 39737.2 40061.2 40070.2 40139.4 34229.0 34424.0 34760.0 34797.7 35092.8 24541.8 24576.4 24640.6 24734.5 24924.0 17:53:59 INFO - PID 23316 | 17:53:59 INFO - PID 23316 | [#2] jquery.html Cycles:180 Average:36039.82 Median:23813.00 stddev:85283.45 (358.1%) stddev-sans-first:85481.14 17:53:59 INFO - PID 23316 | Values: 581.2 581.8 587.2 590.6 602.9 22922.4 23814.0 23848.8 23883.0 23884.8 21159.5 24270.5 24739.6 26892.9 26956.2 6499.7 6659.5 6660.5 6665.1 6668.7 6194.9 6519.2 6563.2 6564.5 6576.9 6436.9 6438.4 6460.6 6461.0 6470.6 6435.2 6436.8 6453.1 6459.7 6461.2 5993.5 5999.3 6003.1 6003.4 6015.8 29419.6 30239.8 30529.1 30667.5 30775.4 1942.6 1994.1 1994.5 1995.2 1997.9 19146.0 19636.7 19657.1 19790.4 19841.3 2386.4 2420.3 2472.9 2527.4 2530.0 120531.4 128853.0 138974.0 140860.3 147805.3 14723.7 15000.0 15004.9 15262.7 15713.0 23676.4 23697.0 23793.5 23812.0 23868.8 10602.5 10610.4 10624.7 10675.1 10745.9 9875.2 9896.4 9970.0 9979.3 10025.6 9378.2 9583.5 9588.0 9612.2 9685.6 2664.7 2718.1 2744.7 2771.4 2786.6 950.6 968.9 971.3 977.8 982.0 19090.4 19932.8 20088.1 20115.8 24092.2 1017.7 1035.1 1045.2 1061.0 1064.6 11085.4 11366.1 11379.0 11381.4 11545.3 482846.0 501753.0 514205.0 514813.0 516177.0 120102.4 124966.0 126297.0 126436.0 127530.4 1243.6 1279.3 1292.6 1304.8 1310.6 21069.7 21197.9 21582.7 21594.4 21602.8 58710.7 60244.4 60726.4 62127.4 62329.7 70484.3 75683.0 78846.0 79926.0 80039.6 14595.9 15113.2 15219.8 15253.8 15289.5 23845.2 24032.5 24039.0 24138.5 24419.5 18824.0 18967.6 19044.2 19286.7 19320.8 16833.4 17262.1 17591.6 17734.2 17875.6 18544.6 19864.9 19882.9 19899.4 20181.0 14750.6 15061.8 15071.3 15079.6 15112.9 18616.9 18712.3 18717.7 18773.1 18844.2 17:53:59 INFO - PID 23316 | 17:53:59 INFO - PID 23316 | [#3] mootools.html Cycles:180 Average:8768.24 Median:2581.14 stddev:5925.18 (229.6%) stddev-sans-first:5915.74 17:53:59 INFO - PID 23316 | Values: 1371.7 1417.6 1418.2 1432.2 1432.3 13723.9 13959.7 14312.6 14313.6 14336.4 14350.1 14471.5 14548.6 14560.8 14636.0 2685.0 2748.8 2751.2 2751.9 2752.6 2469.2 2705.1 2750.3 2756.1 2757.6 2639.3 2664.9 2670.3 2691.0 2698.7 2572.8 2577.9 2606.1 2607.1 2608.3 2551.7 2574.3 2579.6 2582.7 2585.5 13311.5 13626.5 13635.1 13650.1 13655.7 7412.7 7654.9 7660.8 7672.7 7676.1 4958.5 5109.4 5190.4 5277.3 5282.9 1813.4 1839.8 1854.4 1880.6 1883.9 22260.8 22718.0 22733.0 22747.7 22793.9 6731.0 6737.2 6837.8 6959.9 7007.4 17919.5 17933.5 17965.1 17978.6 18021.4 7637.4 7918.4 7936.8 7954.4 7957.7 6140.1 6321.0 7022.4 7118.7 7124.1 5554.7 5563.5 5606.9 5651.3 5665.2 1702.4 1704.5 1720.4 1739.1 1744.5 889.9 902.4 906.5 916.3 919.3 7213.3 7275.6 7285.7 7292.1 7402.2 725.4 727.4 730.2 736.6 738.4 4605.5 4996.6 5204.0 5217.6 5280.8 18561.0 19145.5 19198.7 19291.8 19301.0 18720.4 18768.7 18820.1 18827.0 19051.5 10578.5 10735.9 10820.1 10828.5 10848.6 8213.3 8416.3 8524.0 8539.4 8585.6 16479.6 16657.4 16745.4 16879.7 16918.2 16766.2 16885.7 17035.5 17072.7 17130.0 10202.7 10653.3 10693.0 10702.0 10769.5 13203.0 13424.4 13427.0 13431.2 13439.1 10437.4 10605.2 10629.4 10694.4 10840.7 10650.9 10800.2 10870.9 10938.3 11080.4 9446.5 9627.6 9638.6 9661.6 9679.7 7362.6 7443.7 7462.0 7486.6 7518.4 7172.6 7249.7 7272.6 7297.2 7359.8 17:53:59 INFO - PID 23316 | 17:53:59 INFO - PID 23316 | [#4] prototype.html Cycles:180 Average:5472.67 Median:6184.69 stddev:1526.36 (24.7%) stddev-sans-first:1484.30 17:53:59 INFO - PID 23316 | Values: 499.5 504.3 519.3 522.9 535.4 6249.2 6259.0 6260.0 6269.2 6282.0 6179.9 6189.5 6204.4 6209.9 6211.0 5087.1 5105.3 5136.0 5144.0 5151.8 4790.7 4992.3 5129.8 5133.6 5135.7 4854.8 4868.0 4892.7 4909.5 4909.7 4862.5 4865.5 4872.5 4896.6 4956.8 4305.3 4400.3 4400.5 4431.5 4436.2 5876.7 5925.4 5946.6 5948.2 5988.9 5576.9 5577.7 5630.0 5672.7 5697.3 6429.1 6439.8 6485.3 6490.3 6513.1 4808.3 4833.8 4838.9 4847.5 4853.5 6570.0 6650.3 6660.2 6729.5 6753.0 4934.5 4952.7 4967.2 4977.2 4991.4 5065.5 5066.4 5083.8 5083.9 5092.3 5605.4 5617.0 5623.8 5632.5 5635.9 6535.8 6564.5 6566.8 6596.5 6603.5 1762.8 1768.7 1769.0 1769.9 1774.4 1174.6 1218.8 1222.3 1222.8 1241.1 5699.6 5792.7 5797.9 5826.0 5839.3 6683.5 6729.8 6789.7 6799.2 6818.7 5683.8 5735.6 5748.7 5754.5 5833.1 3526.6 3534.1 3567.5 3573.9 3601.4 6400.5 6434.1 6511.4 6532.4 6587.1 6737.2 6814.0 6872.9 6878.9 6895.7 6366.7 6442.4 6459.2 6469.9 6584.3 6273.3 6636.6 6674.3 6694.1 6777.7 6528.8 6537.9 6540.1 6614.5 6687.2 6294.2 6363.3 6443.8 6463.2 6476.4 4912.8 4925.9 4949.0 4996.2 5021.3 6452.5 6558.9 6620.1 6697.6 6737.4 6405.8 6429.6 6469.8 6483.5 6544.0 6418.0 6463.9 6482.9 6493.8 6504.8 6295.8 6329.0 6381.5 6389.6 6411.6 6427.7 6429.6 6458.2 6488.4 6534.4 6261.0 6326.5 6328.5 6334.4 6360.6 17:53:59 INFO - PID 23316 | 17:53:59 INFO - PID 23316 | [#5] yui.html Cycles:180 Average:23329.55 Median:20583.19 stddev:31405.59 (152.6%) stddev-sans-first:31448.43 17:53:59 INFO - PID 23316 | Values: 874.3 890.2 901.9 903.9 905.0 18579.2 19550.7 19573.9 19592.9 21890.5 21747.5 22090.7 22350.9 22365.9 22383.9 978.9 1013.8 1017.1 1017.2 1017.5 997.5 1031.1 1068.0 1068.3 1069.6 1117.5 1125.5 1126.3 1128.4 1139.2 1120.3 1124.0 1125.5 1127.5 1127.7 825.9 826.8 827.1 827.9 828.1 18442.4 18637.7 20387.9 20579.8 20586.6 22061.2 22105.7 22308.0 22345.0 22596.1 16174.8 16375.3 16432.8 16569.0 16654.4 3640.2 3672.5 3673.6 3683.8 3687.5 125312.0 126372.4 127121.0 129610.0 130245.3 16728.9 17262.1 17368.8 17421.4 17785.0 31943.5 32182.4 32265.0 32650.2 32679.8 8067.0 8408.3 8752.2 9055.8 9306.2 4218.2 4270.9 4278.4 4294.4 4315.3 4901.8 4975.7 4984.5 5032.3 5056.5 1003.7 1034.7 1039.1 1040.1 1043.7 613.9 621.2 625.5 626.8 647.9 11739.6 12025.2 12403.3 12674.7 13046.7 586.6 624.7 632.8 638.3 646.1 5324.6 5556.7 5613.3 5747.1 5806.1 104273.0 107258.0 108082.5 109684.5 111749.0 93646.0 94073.5 94178.5 96068.0 96599.5 86423.0 86471.6 87930.0 89788.6 90071.0 10666.1 10872.7 11087.1 11123.0 11221.9 37858.2 38486.2 38799.0 38920.0 40293.0 49401.5 49680.8 50276.2 50466.0 51364.7 13979.7 16545.0 16981.3 17064.4 17080.4 22158.8 22215.9 22770.9 22867.8 22875.9 18518.2 19093.9 19561.2 19698.5 20326.0 17372.0 17996.0 18013.8 18373.4 18512.4 18643.3 18767.7 19050.3 19102.4 19315.8 13529.0 13729.7 13758.2 13986.4 14128.2 12628.8 12953.6 13263.3 13776.2 14746.9 17:53:59 INFO - PID 23316 | -------- Summary: end -------- 17:53:59 INFO - PID 23316 | 17:54:00 INFO - TEST-INFO | 23316: exit 0 17:54:00 INFO - TEST-OK | dromaeo_css | took 1111078ms 17:54:00 INFO - TEST-START | kraken 17:54:00 INFO - Initialising browser for kraken test... 17:54:00 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:33683/getInfo.html -profile /tmp/tmpbFBPyX/profile 17:54:00 INFO - TEST-INFO | started process 23738 (/builds/slave/test/build/application/firefox/firefox http://localhost:33683/getInfo.html) 17:54:06 INFO - TEST-INFO | 23738: exit 0 17:54:06 INFO - Browser initialized. 17:54:06 INFO - Running cycle 1/1 for kraken test... 17:54:06 INFO - TEST-INFO | started process 23926 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbFBPyX/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 17:54:07 INFO - PID 23926 | 17:54:07 INFO - PID 23926 | (/builds/slave/test/build/application/firefox/firefox:23976): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 17:54:07 INFO - PID 23926 | 17:54:07 INFO - PID 23926 | 17:54:07 INFO - PID 23926 | (/builds/slave/test/build/application/firefox/firefox:24036): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 17:54:07 INFO - PID 23926 | 17:54:08 INFO - PID 23926 | __metrics Screen width/height:1600/1200 17:54:08 INFO - PID 23926 | colorDepth:24 17:54:08 INFO - PID 23926 | Browser inner width/height: 1024/768 17:54:08 INFO - PID 23926 | __metrics 17:54:17 INFO - PID 23926 | RSS: Main: 174284800 17:54:17 INFO - PID 23926 | 17:54:20 INFO - PID 23926 | Cycle 1(1): loaded http://localhost:33683/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:33683/tests/kraken/driver.html?testName=audio-beat-detection) 17:54:21 INFO - PID 23926 | RSS: Main: 178290688 17:54:21 INFO - PID 23926 | 17:54:23 INFO - PID 23926 | Cycle 1(1): loaded http://localhost:33683/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:33683/tests/kraken/driver.html?testName=audio-dft) 17:54:24 INFO - PID 23926 | RSS: Main: 179056640 17:54:24 INFO - PID 23926 | 17:54:27 INFO - PID 23926 | Cycle 1(1): loaded http://localhost:33683/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:33683/tests/kraken/driver.html?testName=audio-fft) 17:54:28 INFO - PID 23926 | RSS: Main: 173527040 17:54:28 INFO - PID 23926 | 17:54:30 INFO - PID 23926 | Cycle 1(1): loaded http://localhost:33683/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:33683/tests/kraken/driver.html?testName=audio-oscillator) 17:54:31 INFO - PID 23926 | RSS: Main: 174338048 17:54:31 INFO - PID 23926 | 17:54:33 INFO - PID 23926 | Cycle 1(1): loaded http://localhost:33683/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:33683/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:54:33 INFO - PID 23926 | RSS: Main: 174727168 17:54:33 INFO - PID 23926 | 17:54:37 INFO - PID 23926 | Cycle 1(1): loaded http://localhost:33683/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:33683/tests/kraken/driver.html?testName=imaging-darkroom) 17:54:37 INFO - PID 23926 | RSS: Main: 175763456 17:54:37 INFO - PID 23926 | 17:54:41 INFO - PID 23926 | Cycle 1(1): loaded http://localhost:33683/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:33683/tests/kraken/driver.html?testName=imaging-desaturate) 17:54:41 INFO - PID 23926 | RSS: Main: 175730688 17:54:41 INFO - PID 23926 | 17:54:44 INFO - PID 23926 | Cycle 1(1): loaded http://localhost:33683/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:33683/tests/kraken/driver.html?testName=json-parse-financial) 17:54:45 INFO - PID 23926 | RSS: Main: 176222208 17:54:45 INFO - PID 23926 | 17:54:47 INFO - PID 23926 | Cycle 1(1): loaded http://localhost:33683/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:33683/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:54:47 INFO - PID 23926 | RSS: Main: 175886336 17:54:47 INFO - PID 23926 | 17:54:49 INFO - PID 23926 | Cycle 1(1): loaded http://localhost:33683/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:33683/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:54:50 INFO - PID 23926 | RSS: Main: 176259072 17:54:50 INFO - PID 23926 | 17:54:52 INFO - PID 23926 | Cycle 1(1): loaded http://localhost:33683/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:33683/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:54:52 INFO - PID 23926 | RSS: Main: 176148480 17:54:52 INFO - PID 23926 | 17:54:55 INFO - PID 23926 | Cycle 1(1): loaded http://localhost:33683/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:33683/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:54:56 INFO - PID 23926 | RSS: Main: 176128000 17:54:56 INFO - PID 23926 | 17:54:59 INFO - PID 23926 | Cycle 1(1): loaded http://localhost:33683/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:33683/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:55:00 INFO - PID 23926 | RSS: Main: 176508928 17:55:00 INFO - PID 23926 | 17:55:01 INFO - PID 23926 | Cycle 1(1): loaded http://localhost:33683/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:33683/tests/kraken/driver.html?testName=ai-astar) 17:55:02 INFO - PID 23926 | RSS: Main: 177889280 17:55:02 INFO - PID 23926 | 17:55:02 INFO - PID 23926 | __start_tp_report 17:55:02 INFO - PID 23926 | _x_x_mozilla_page_load 17:55:02 INFO - PID 23926 | _x_x_mozilla_page_load_details 17:55:02 INFO - PID 23926 | |i|pagename|runs| 17:55:02 INFO - PID 23926 | |0;ai-astar;98;108;110;108;106;118;111;100;109;109 17:55:02 INFO - PID 23926 | |1;audio-beat-detection;144;121;151;168;118;143;120;163;153;124 17:55:02 INFO - PID 23926 | |2;audio-dft;163;164;162;161;162;164;165;170;169;164 17:55:02 INFO - PID 23926 | |3;audio-fft;75;88;76;156;77;76;74;85;98;76 17:55:02 INFO - PID 23926 | |4;audio-oscillator;78;79;126;79;82;78;126;79;78;128 17:55:02 INFO - PID 23926 | |5;imaging-gaussian-blur;117;114;113;117;116;118;115;115;115;115 17:55:02 INFO - PID 23926 | |6;imaging-darkroom;151;149;149;149;150;150;150;150;150;151 17:55:02 INFO - PID 23926 | |7;imaging-desaturate;94;94;95;95;93;93;95;99;96;95 17:55:02 INFO - PID 23926 | |8;json-parse-financial;54;60;53;53;54;57;55;59;51;54 17:55:02 INFO - PID 23926 | |9;json-stringify-tinderbox;57;54;54;54;61;55;58;54;54;56 17:55:02 INFO - PID 23926 | |10;stanford-crypto-aes;85;77;79;76;81;82;79;76;79;82 17:55:02 INFO - PID 23926 | |11;stanford-crypto-ccm;123;130;127;125;118;126;127;129;123;158 17:55:02 INFO - PID 23926 | |12;stanford-crypto-pbkdf2;178;181;179;186;180;178;176;178;175;185 17:55:02 INFO - PID 23926 | |13;stanford-crypto-sha256-iterative;71;72;71;67;66;69;70;71;69;71 17:55:02 INFO - PID 23926 | __end_tp_report 17:55:02 INFO - PID 23926 | __start_cc_report 17:55:02 INFO - PID 23926 | _x_x_mozilla_cycle_collect,967 17:55:02 INFO - PID 23926 | __end_cc_report 17:55:02 INFO - PID 23926 | __startTimestamp1503363302183__endTimestamp 17:55:02 INFO - PID 23926 | 17:55:02 INFO - PID 23926 | ------- Summary: start ------- 17:55:02 INFO - PID 23926 | Number of tests: 14 17:55:02 INFO - PID 23926 | 17:55:02 INFO - PID 23926 | [#0] ai-astar Cycles:10 Average:107.70 Median:109.50 stddev:5.60 (5.1%) stddev-sans-first:4.71 17:55:02 INFO - PID 23926 | Values: 98.0 108.0 110.0 108.0 106.0 118.0 111.0 100.0 109.0 109.0 17:55:02 INFO - PID 23926 | 17:55:02 INFO - PID 23926 | [#1] audio-beat-detection Cycles:10 Average:140.50 Median:147.50 stddev:18.64 (12.6%) stddev-sans-first:19.73 17:55:02 INFO - PID 23926 | Values: 144.0 121.0 151.0 168.0 118.0 143.0 120.0 163.0 153.0 124.0 17:55:02 INFO - PID 23926 | 17:55:02 INFO - PID 23926 | [#2] audio-dft Cycles:10 Average:164.40 Median:164.00 stddev:2.95 (1.8%) stddev-sans-first:3.09 17:55:02 INFO - PID 23926 | Values: 163.0 164.0 162.0 161.0 162.0 164.0 165.0 170.0 169.0 164.0 17:55:02 INFO - PID 23926 | 17:55:02 INFO - PID 23926 | [#3] audio-fft Cycles:10 Average:88.10 Median:76.50 stddev:25.06 (32.8%) stddev-sans-first:26.13 17:55:02 INFO - PID 23926 | Values: 75.0 88.0 76.0 156.0 77.0 76.0 74.0 85.0 98.0 76.0 17:55:02 INFO - PID 23926 | 17:55:02 INFO - PID 23926 | [#4] audio-oscillator Cycles:10 Average:93.30 Median:78.50 stddev:23.06 (29.4%) stddev-sans-first:23.79 17:55:02 INFO - PID 23926 | Values: 78.0 79.0 126.0 79.0 82.0 78.0 126.0 79.0 78.0 128.0 17:55:02 INFO - PID 23926 | 17:55:02 INFO - PID 23926 | [#5] imaging-gaussian-blur Cycles:10 Average:115.50 Median:115.50 stddev:1.51 (1.3%) stddev-sans-first:1.50 17:55:02 INFO - PID 23926 | Values: 117.0 114.0 113.0 117.0 116.0 118.0 115.0 115.0 115.0 115.0 17:55:02 INFO - PID 23926 | 17:55:02 INFO - PID 23926 | [#6] imaging-darkroom Cycles:10 Average:149.90 Median:150.00 stddev:0.74 (0.5%) stddev-sans-first:0.67 17:55:02 INFO - PID 23926 | Values: 151.0 149.0 149.0 149.0 150.0 150.0 150.0 150.0 150.0 151.0 17:55:02 INFO - PID 23926 | 17:55:02 INFO - PID 23926 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:1.73 (1.8%) stddev-sans-first:1.80 17:55:02 INFO - PID 23926 | Values: 94.0 94.0 95.0 95.0 93.0 93.0 95.0 99.0 96.0 95.0 17:55:02 INFO - PID 23926 | 17:55:02 INFO - PID 23926 | [#8] json-parse-financial Cycles:10 Average:55.00 Median:54.50 stddev:2.83 (5.2%) stddev-sans-first:2.98 17:55:02 INFO - PID 23926 | Values: 54.0 60.0 53.0 53.0 54.0 57.0 55.0 59.0 51.0 54.0 17:55:02 INFO - PID 23926 | 17:55:02 INFO - PID 23926 | [#9] json-stringify-tinderbox Cycles:10 Average:55.70 Median:55.50 stddev:2.36 (4.3%) stddev-sans-first:2.46 17:55:02 INFO - PID 23926 | Values: 57.0 54.0 54.0 54.0 61.0 55.0 58.0 54.0 54.0 56.0 17:55:02 INFO - PID 23926 | 17:55:02 INFO - PID 23926 | [#10] stanford-crypto-aes Cycles:10 Average:79.60 Median:80.00 stddev:2.91 (3.6%) stddev-sans-first:2.35 17:55:02 INFO - PID 23926 | Values: 85.0 77.0 79.0 76.0 81.0 82.0 79.0 76.0 79.0 82.0 17:55:02 INFO - PID 23926 | 17:55:02 INFO - PID 23926 | [#11] stanford-crypto-ccm Cycles:10 Average:128.60 Median:127.00 stddev:10.89 (8.6%) stddev-sans-first:11.36 17:55:02 INFO - PID 23926 | Values: 123.0 130.0 127.0 125.0 118.0 126.0 127.0 129.0 123.0 158.0 17:55:02 INFO - PID 23926 | 17:55:02 INFO - PID 23926 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:179.60 Median:179.50 stddev:3.57 (2.0%) stddev-sans-first:3.73 17:55:02 INFO - PID 23926 | Values: 178.0 181.0 179.0 186.0 180.0 178.0 176.0 178.0 175.0 185.0 17:55:02 INFO - PID 23926 | 17:55:02 INFO - PID 23926 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.70 Median:71.00 stddev:1.95 (2.7%) stddev-sans-first:2.01 17:55:02 INFO - PID 23926 | Values: 71.0 72.0 71.0 67.0 66.0 69.0 70.0 71.0 69.0 71.0 17:55:02 INFO - PID 23926 | -------- Summary: end -------- 17:55:02 INFO - PID 23926 | 17:55:02 INFO - PID 23926 | 17:55:02 INFO - PID 23926 | ###!!! [Parent][MessageChannel] Error: (msgtype=0x150079,name=PBrowser::Msg_Destroy) Closed channel: cannot send/recv 17:55:02 INFO - PID 23926 | 17:55:02 INFO - PID 23926 | 17:55:02 INFO - PID 23926 | ###!!! [Child][MessageChannel] Error: (msgtype=0x150001,name=PBrowser::Msg_AsyncMessage) Closed channel: cannot send/recv 17:55:02 INFO - PID 23926 | 17:55:02 INFO - PID 23926 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 17:55:02 INFO - TEST-INFO | 23926: exit 0 17:55:02 INFO - TEST-OK | kraken | took 62305ms 17:55:02 INFO - SUITE-END | took 1173s 17:55:03 INFO - Completed test suite (00:19:33) 17:55:03 INFO - javascript benchmark 17:55:03 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8545.23622381133, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3098.6436559795616, 3122.750179985601, 3123.6251649802025, 3152.558641790149, 3161.8419079046043, 6070.635761854286, 6236.501079913607, 6243.375662433755, 6262.0919966604815, 6283.151774510446, 6092.421219984094, 6192.1021451889565, 6199.473044791198, 6216.129741836146, 6242.906356404646, 5648.124540696178, 5650.830475085733, 5666.0, 5707.857303567403, 5724.570657200706, 5750.424957504258, 5758.510526605243, 5759.1361295805755, 5760.798372056979, 5770.884582308351, 143.6669262680065, 5556.277683901067, 5670.432956704338, 5767.711614419283, 5798.246227990356, 5578.9163162552595, 5583.469570390847, 5609.102543593046, 5682.54539636828, 5712.714364281769, 5569.443055694439, 5576.6375185613215, 5635.1828984797385, 5649.435056494359, 5651.7739290428335, 6053.122297266916, 6080.574359794772, 6087.573869829113, 6143.631382117042, 6173.135760993465, 6584.440322572587, 6643.534952553323, 6655.500837437163, 6681.498887583402, 6708.0, 6566.376194261537, 6696.7656132035145, 6704.966475167642, 6759.121314229119, 6793.626350550767, 6162.1681073055015, 6206.193194884681, 6240.219972503437, 6244.93836047873, 6247.281562620311, 6841.3842754152365, 6869.622170780655, 6925.307469253135, 6932.549384290005, 6945.583265004116, 6526.510511711545, 6540.4767618590395, 6599.1091202687985, 6610.7025183866845, 6634.336566343423, 6542.116814230113, 6620.271770105284, 6638.535302528777, 6644.235912870082, 6717.328267173243, 6618.602883826986, 6662.600243985376, 6668.166479190101, 6685.0640910272605, 6719.664016799141, 6656.101426307387, 6713.765018224436, 6715.832104197434, 6727.93272067273, 6742.76400325996, 5256.894862102737, 5266.605004624668, 5320.946790532123, 5388.946110538923, 5398.757055932492, 4538.455385353779, 4559.361689363425, 4563.9087218255445, 4572.4055872736335, 4602.953970460319, 5703.0, 5775.768969241268, 5818.272715910512, 5826.475617194473, 5836.766529338864, 6558.147440832661, 6626.966865165643, 6703.396694297439, 6728.394444500019, 6738.59568425896, 5759.280089988752, 5766.365699773021, 5831.504322132581, 5836.358000619928, 5845.327787304429, 5755.050416681284, 5807.419258074159, 5867.70661466925, 5892.027815410495, 5894.292684877756, 6447.838804029937, 6470.255920569195, 6470.45001174896, 6489.610623362613, 6559.0, 6676.432503237182, 6676.83307917306, 6751.831204219934, 6773.390394864486, 6778.051072849904, 6434.678266086583, 6460.709268083042, 6480.384363485461, 6536.215654121535, 6566.737330506918, 6457.741690332522, 6533.67331633407, 6541.574797638138, 6542.803715888531, 6549.24683661366, 6563.0, 6582.506312026521, 6634.270230274569, 6651.46788256948, 6652.534322597372, 6319.96840015797, 6339.175907132043, 6366.267879193767, 6414.647194404166, 6434.549581529248, 6387.297397286387, 6387.712552935036, 6418.133551970424, 6425.453836423956, 6438.163038804925, 6243.656598887105, 6267.780627678009, 6311.084892690626, 6398.648074355955, 6413.230412350361, 6407.423331900151, 6463.224413070461, 6465.903011454926, 6496.6751662415745, 6571.441427478527, 6189.164462797465, 6255.9374406257175, 6320.209973753281, 6351.301356850835, 6357.523185760994], "value": 6022.210896947745, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [828.304224451461, 877.4647465046321, 890.6214858685057, 901.0358915959921, 1181.539199712113, 32268.0, 32776.67223327766, 43572.346414803804, 44192.779036104774, 44423.555764442346, 44405.555944440544, 44827.32759008609, 44932.775336123355, 44934.32598511017, 44964.100717985624, 6546.9017964730565, 7862.095858976205, 7963.124056353797, 7978.880316795253, 8036.758897233063, 7866.685332586719, 7890.8816367754525, 7971.760847174565, 7975.361971042303, 7979.760607181794, 8006.119326874039, 8070.233327833876, 8071.919280807205, 8075.030996280425, 8075.5154690718455, 7975.082865470487, 7985.640646170937, 8015.519068855887, 8019.639116239783, 8034.397420193509, 7871.330936870316, 7916.485428447132, 7917.168697286817, 7922.168172341936, 7923.247291507298, 40387.7980610098, 40724.38913416301, 40735.796321018504, 40744.0, 40745.0, 3558.857645694169, 3601.1897323102353, 3620.7646502977223, 3628.5101511296166, 3631.1285291530107, 31810.0, 31854.0, 31944.680553194634, 32068.358632827214, 32130.0, 4871.12319782439, 5132.871678208075, 5151.5878729701535, 5175.45657705943, 5181.844544663666, 177091.0, 177221.99999999872, 177718.0, 177960.0, 178017.0, 49481.752591236815, 50025.24962125571, 51577.0, 51846.74076629593, 51847.48152518502, 54109.72945135249, 54462.45537544574, 54694.726526367114, 54696.0, 54778.0, 16500.917495412687, 16729.49811505657, 16824.074675892698, 16872.325106995828, 16974.83025169757, 13629.591112266648, 13698.52055178064, 13701.794473082911, 13730.244836534086, 13730.65673358174, 14802.0, 14916.328765205591, 14918.0, 14942.0, 15057.397704091714, 5860.355360910296, 5872.706364681749, 5878.118282257696, 5972.163897054415, 5975.701214939236, 975.5853762151057, 983.5868935047297, 983.6606370802061, 994.4083270454068, 1022.7801022780138, 23145.749471922216, 23149.537009259722, 23219.419514511934, 23551.41121471977, 23754.524909501713, 1106.0764261841452, 1113.7995160871121, 1124.6738445850776, 1128.9379084150287, 1129.175701737736, 12315.75368492643, 12403.193792403465, 12410.627681169399, 12502.437390317458, 12504.499820007099, 238845.0, 239399.0, 239711.0, 240699.0, 240986.0, 54507.72746136323, 54662.0, 54736.17895731567, 54754.45245547573, 54831.0, 1440.3662388549005, 1446.428660679047, 1490.411287541415, 1492.5373134328393, 1497.3636204612997, 22555.887220563793, 22815.771842281363, 22853.0, 22919.656205156603, 22986.885065574566, 38720.2255954885, 38789.0, 38789.6121038786, 38801.61198388093, 38855.6114438852, 208805.0, 214869.0, 215066.0, 215399.0, 215585.0, 37908.81045594755, 37952.62047379491, 37998.62001379951, 38296.808515957244, 38369.4244586337, 47831.0, 48226.0, 48304.7584762074, 48386.75806620944, 48388.0, 34602.48096278608, 34667.826660866536, 34776.82611587027, 35597.28805423929, 35764.46353304754, 34011.31977360389, 34398.312033759685, 34741.0, 34810.30379392347, 34953.12617184489, 37759.62240377671, 39737.2052558953, 40061.198776024896, 40070.19859602733, 40139.39790903197, 34229.0, 34424.0, 34760.0, 34797.652023480456, 35092.82453587716, 24541.75458245395, 24576.38559035967, 24640.630390544517, 24734.505309894063, 24924.003039878928], "value": 17831.612372609878, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [581.1660267516115, 581.7818318130703, 587.1926101610286, 590.6220019187718, 602.8643555200081, 22922.426939326506, 23814.0, 23848.761512384892, 23883.0, 23884.76115238847, 21159.471013224676, 24270.514589708197, 24739.628905566387, 26892.865535672343, 26956.191314260555, 6499.675016249181, 6659.533832631718, 6660.533762636617, 6665.133532640774, 6668.666566671672, 6194.946859033953, 6519.185101862267, 6563.1796025496815, 6564.474842012652, 6576.901346479783, 6436.871262574746, 6438.356164383547, 6460.612363258196, 6460.967695161541, 6470.644114573696, 6435.195600549931, 6436.839079023015, 6453.064305675674, 6459.709313080899, 6461.224653041641, 5993.490553302974, 5999.310079340888, 6003.129546215818, 6003.369646187175, 6015.849603759941, 29419.558706619417, 30239.848800755855, 30529.08412747621, 30667.539986900214, 30775.38449231025, 1942.5726340205274, 1994.1425187169511, 1994.5013746563359, 1995.2318357432348, 1997.8601497895154, 19146.0, 19636.70544941827, 19657.115429805694, 19790.406287811387, 19841.305554305673, 2386.4033991502124, 2420.261820144855, 2472.876356182184, 2527.36815796051, 2530.0, 120531.3973430136, 128853.0, 138974.0, 140860.29569852186, 147805.26097369552, 14723.705525889422, 15000.024998375071, 15004.874634402464, 15262.694746105015, 15713.0, 23676.408089797547, 23697.0, 23793.52412951731, 23812.0, 23868.761312387, 10602.469876506144, 10610.416427096583, 10624.653234231193, 10675.092617127475, 10745.892541074489, 9875.160611347972, 9896.416573348373, 9969.950150249348, 9979.301448898508, 10025.598976041023, 9378.155965963097, 9583.520823958774, 9587.952060239653, 9612.18296444796, 9685.612575497042, 2664.653595032672, 2718.143784707811, 2744.7118052604587, 2771.418002219516, 2786.5820126981116, 950.5817440326234, 968.9031096890395, 971.3443425687774, 977.8386566216494, 981.9950900245595, 19090.427287181406, 19932.800671993093, 20088.09603567843, 20115.798842011685, 24092.15677451281, 1017.6590842067842, 1035.1304903880775, 1045.210865796319, 1060.9522571484301, 1064.5794911010262, 11085.445727713743, 11366.09071274296, 11379.032782213604, 11381.374024428736, 11545.307281563133, 482846.0, 501753.0, 514205.0, 514813.0, 516177.0, 120102.399488002, 124966.0, 126297.0, 126436.0, 127530.36234818767, 1243.564752336675, 1279.270815635079, 1292.5799115287568, 1304.7716649586284, 1310.593715948059, 21069.683954740998, 21197.894010530465, 21582.6762598558, 21594.352169434944, 21602.783972160076, 58710.70644646749, 60244.39755602563, 60726.39273607208, 62127.37872621216, 62329.688351557954, 70484.29515704777, 75683.0, 78846.0, 79926.0, 80039.59980200062, 14595.85404145945, 15113.244337783286, 15219.847801522286, 15253.847461525243, 15289.541313760605, 23845.165419210243, 24032.51934961326, 24039.0, 24138.51722965566, 24419.511609768062, 18823.964681942078, 18967.620647587246, 19044.238230470626, 19286.71069933924, 19320.8067919319, 16833.41083062087, 17262.136893155544, 17591.648167036845, 17734.20196091153, 17875.553111172325, 18544.629107417506, 19864.90067549711, 19882.90058549698, 19899.403017909484, 20181.0, 14750.55748327552, 15061.849381506045, 15071.321790519234, 15079.64283214516, 15112.924435377752, 18616.906915465337, 18712.25150993945, 18717.71923421177, 18773.06134693287, 18844.246230151188], "value": 12335.57057142182, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1371.6570857285676, 1417.5818133650575, 1418.1987177244855, 1432.1979691372826, 1432.2838580709638, 13723.931380343096, 13959.651008724786, 14312.570622881318, 14313.642158946019, 14336.354864031118, 14350.067245629027, 14471.493497727583, 14548.636284092903, 14560.781588276184, 14636.0, 2685.04680838302, 2748.8213266137636, 2751.2296556964084, 2751.862406879648, 2752.628395166657, 2469.2098528470897, 2705.147878418292, 2750.3124218945263, 2756.145594865588, 2757.600147978542, 2639.313778417606, 2664.9333766655795, 2670.305720512661, 2690.9596356054676, 2698.689650690176, 2572.8199026068182, 2577.90977315794, 2606.1399738086384, 2607.1005503101496, 2608.282722251377, 2551.6810398700163, 2574.266334094793, 2579.587266037444, 2582.690077190749, 2585.482903419305, 13311.467541298336, 13626.454941802316, 13635.113717608323, 13650.112742671694, 13655.726885462234, 7412.666430010609, 7654.923450765533, 7660.770176894702, 7672.693092276302, 7676.11724651661, 4958.479359667219, 5109.3613298337705, 5190.429052804188, 5277.313949186581, 5282.947170528284, 1813.3925135079633, 1839.8160183981495, 1854.378783107647, 1880.5862710203733, 1883.858710596697, 22260.777392226195, 22718.0, 22732.999999999836, 22747.658785118238, 22793.886030569905, 6730.966345168341, 6737.225219099866, 6837.794866154023, 6959.930400695928, 7007.4394048476, 17919.46241612754, 17933.461996140137, 17965.101744912703, 17978.55053623644, 18021.369252076114, 7637.42719296055, 7918.445708800328, 7936.841263174704, 7954.443188976716, 7957.721479748181, 6140.078988151724, 6321.0, 7022.40309573692, 7118.715251389886, 7124.073870396919, 5554.666719996813, 5563.5271001964475, 5606.887862242732, 5651.2935883014625, 5665.206871038058, 1702.4467048209133, 1704.548294701905, 1720.380662961333, 1739.1391261325725, 1744.5376975101608, 889.8798662180652, 902.4044130873592, 906.4968942237122, 916.2807196350833, 919.2554031234721, 7213.278672132745, 7275.599842008741, 7285.708571657075, 7292.088488938883, 7402.185759566443, 725.361681720083, 727.3962611032936, 730.1639622632057, 736.6353654940839, 738.4129616954534, 4605.539446055434, 4996.625253105959, 5204.0, 5217.634765566374, 5280.841574752763, 18561.0, 19145.521361965784, 19198.712019319722, 19291.80708192928, 19301.0, 18720.438386848415, 18768.71846922297, 18820.05899705009, 18827.0, 19051.523711907037, 10578.471076446147, 10735.89264107349, 10820.13438924884, 10828.512716927757, 10848.566057357617, 8213.3429325655, 8416.284615807725, 8523.95738021306, 8539.402241843012, 8585.613647386008, 16479.588010299358, 16657.416990405276, 16745.413910513074, 16879.74680379771, 16918.238679259215, 16766.161691915113, 16885.662286754443, 17035.48893533196, 17072.658546829243, 17130.030046544307, 10202.744931376776, 10653.254272200871, 10693.0, 10702.0, 10769.515371808444, 13203.0, 13424.39590218423, 13427.0, 13431.19412835233, 13439.126456780277, 10437.373757574569, 10605.151587873106, 10629.36223826542, 10694.41180735067, 10840.67477975662, 10650.8934910653, 10800.24398292112, 10870.945645272039, 10938.343699378063, 11080.390578517936, 9446.480443575669, 9627.614895404105, 9638.566264518253, 9661.613535458784, 9679.66121185755, 7362.595057271901, 7443.665035073326, 7462.029936108272, 7486.6256687166515, 7518.360939320219, 7172.641367931687, 7249.673764680497, 7272.563646181246, 7297.160826504807, 7359.77920662381], "value": 6400.478040607244, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [499.53199187169315, 504.3267238236955, 519.3300642171599, 522.850987468571, 535.4484880573009, 6249.218847644039, 6259.0, 6259.968700156504, 6269.153664255324, 6282.0, 6179.907301390472, 6189.4738947189435, 6204.41058099481, 6209.937900620993, 6210.9689451552795, 5087.135187018197, 5105.310783044297, 5136.04830164537, 5144.0, 5151.793928242866, 4790.736509491977, 4992.326035985132, 5129.846104616849, 5133.589312854962, 5135.666181698178, 4854.781534830941, 4868.0, 4892.6575139740235, 4909.45995940448, 4909.680870743408, 4862.513748625144, 4865.513448655124, 4872.537108974641, 4896.559309662148, 4956.826511072095, 4305.268104422255, 4400.3399490076745, 4400.515943246241, 4431.490378606437, 4436.245838207513, 5876.7355469004, 5925.4370834770625, 5946.583739138262, 5948.226730525047, 5988.940110598882, 5576.888462230732, 5577.6653400796085, 5630.0, 5672.716364181774, 5697.259356283698, 6429.132067170919, 6439.8068057958335, 6485.254195767453, 6490.318516555741, 6513.088167656532, 4808.278758186265, 4833.806647734086, 4838.903221935541, 4847.466778654345, 4853.514648535153, 6570.0, 6650.301718319603, 6660.167479065165, 6729.495287853381, 6753.0, 4934.481879402611, 4952.702837829742, 4967.205247160437, 4977.1538838397555, 4991.35285355839, 5065.518775716301, 5066.417362003343, 5083.771230294646, 5083.8983220335385, 5092.312537807423, 5605.411431799684, 5617.0, 5623.775048997994, 5632.464915832989, 5635.943640563624, 6535.758205940856, 6564.540482166298, 6566.8179727649485, 6596.472282217411, 6603.471722262208, 1762.8237176282269, 1768.6993211154136, 1769.0, 1769.9469015929285, 1774.3612299572144, 1174.5888938871497, 1218.8110842819376, 1222.3216115056052, 1222.81657751338, 1241.0815996162773, 5699.572532060112, 5792.681402522901, 5797.855053623609, 5826.0, 5839.270091238595, 6683.498737594603, 6729.764458243938, 6789.660516974231, 6799.218089919624, 6818.659067046727, 5683.8010669626365, 5735.627184233012, 5748.655080695172, 5754.482096611241, 5833.125031245348, 3526.5768107827225, 3534.0811389039036, 3567.518385017989, 3573.874914377984, 3601.38776408006, 6400.487960963112, 6434.067060276234, 6511.446527045159, 6532.412082912466, 6587.110740050128, 6737.225219099768, 6813.965930170318, 6872.934695122264, 6878.931210687829, 6895.689693963784, 6366.681665916593, 6442.387973142544, 6459.224893012869, 6469.902951455732, 6584.308647591934, 6273.278572964167, 6636.5686230396805, 6674.332566743286, 6694.096296999843, 6777.728890844311, 6528.771492997722, 6537.934620653733, 6540.117084193763, 6614.536982411378, 6687.164104486939, 6294.181756371642, 6363.300036996019, 6443.7744678936015, 6463.192100987377, 6476.384743449365, 4912.82805101834, 4925.926111108264, 4948.950510494849, 4996.15065438869, 5021.347224860745, 6452.54832161763, 6558.934410655832, 6620.139381880324, 6697.631630260187, 6737.393634572912, 6405.839854003687, 6429.6142231466265, 6469.76793006412, 6483.546151769519, 6543.967280163569, 6417.97312430009, 6463.903041454476, 6482.902756458562, 6493.805185844432, 6504.772332968323, 6295.811125666238, 6329.0, 6381.489480841615, 6389.648569328731, 6411.6153030818305, 6427.742890284523, 6429.646369449538, 6458.220916521834, 6488.448481878904, 6534.379233972765, 6260.968695156495, 6326.462250708557, 6328.525360598066, 6334.398232167937, 6360.618362898241], "value": 5025.541509648238, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [874.2918236228655, 890.2210565754964, 901.9413738107019, 903.9276857851372, 904.9502277374742, 18579.163937622805, 19550.706739398902, 19573.923434211112, 19592.90203548982, 21890.452738681543, 21747.456313592167, 22090.668639970412, 22350.888245558748, 22365.888170559123, 22383.888080559573, 978.9363691360056, 1013.7719013222003, 1017.1405162637559, 1017.1913328903539, 1017.4658304390181, 997.5411310797042, 1031.097789434245, 1067.9733006674855, 1068.2735739697002, 1069.6149386220955, 1117.5306371324064, 1125.4766533561892, 1126.2904370246774, 1128.4075860173434, 1139.1570238023844, 1120.2886167283752, 1123.960661376856, 1125.482278152051, 1127.503898284752, 1127.7349822791637, 825.8926339575877, 826.7891687619679, 827.1067247372823, 827.9337652987747, 828.1180542722042, 18442.446726598224, 18637.7204341935, 20387.89806050975, 20579.794202057936, 20586.5882682347, 22061.227857024925, 22105.66841497379, 22308.0, 22345.0, 22596.096156153733, 16174.838251617452, 16375.344986200538, 16432.78157448741, 16569.0, 16654.417095401725, 3640.21735326906, 3672.485851980725, 3673.5775385830702, 3683.778973261613, 3687.483752274684, 125312.0, 126372.36813815964, 127121.0, 129609.99999999905, 130245.34877325647, 16728.912620679617, 17262.136893155544, 17368.82631173672, 17421.39025134114, 17784.99999999974, 31943.520847187312, 32182.35635287328, 32265.0, 32650.18374540608, 32679.836600817318, 8066.959665201636, 8408.32733381328, 8752.168543988311, 9055.773605659911, 9306.208972237435, 4218.219629368516, 4270.914581708348, 4278.422412974271, 4294.3558466230315, 4315.266404711144, 4901.803927842846, 4975.651704380731, 4984.501549845059, 5032.270320803463, 5056.519630635084, 1003.6988903328972, 1034.6844212515255, 1039.0752230514847, 1040.1262939131166, 1043.6503771236721, 613.9355367686329, 621.2234706616729, 625.4902254662436, 626.7680958045553, 647.915770949783, 11739.647810565697, 12025.158238923192, 12403.317817520123, 12674.746505069847, 13046.673833154247, 586.5688718791685, 624.7313655128247, 632.8291361332415, 638.2755572425331, 646.0567571345888, 5324.5740340772645, 5556.72216389187, 5613.326400831927, 5747.109198074305, 5806.129080637938, 104273.0, 107258.0, 108082.45958770155, 109684.4515777432, 111749.0, 93646.0, 94073.52963235277, 94178.52910735403, 96068.0, 96599.51700241453, 86423.0, 86471.56764216139, 87930.0, 89788.5510572443, 90071.0, 10666.093382062301, 10872.728181795519, 11087.113030957666, 11123.0, 11221.887781122085, 37858.24283514369, 38486.23027539378, 38799.0, 38920.0, 40292.992675183355, 49401.50598493969, 49680.75159624179, 50276.245856311456, 50466.0, 51364.74317628388, 13979.720405592034, 16545.0, 16981.320747169975, 17064.402745903833, 17080.402185923434, 22158.77841221567, 22215.88892055594, 22770.886145569166, 22867.771322286564, 22875.88562057179, 18518.16668249959, 19093.90453047726, 19561.21755129779, 19698.50753731168, 20325.983700814606, 17372.0, 17996.0, 18013.819861801738, 18373.356932507297, 18512.44462666122, 18643.347482838035, 18767.718484222474, 19050.333238336592, 19102.426927192206, 19315.8068419314, 13529.0, 13729.725405492034, 13758.243296618783, 13986.370613322222, 14128.152310861382, 12628.810567841307, 12953.611391658265, 13263.2705201211, 13776.173429594257, 14746.852531474977], "value": 9137.235309454732, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1522.4999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 108.0, 110.0, 108.0, 106.0, 118.0, 111.0, 100.0, 109.0, 109.0], "value": 107.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 121.0, 151.0, 168.0, 118.0, 143.0, 120.0, 163.0, 153.0, 124.0], "value": 140.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 164.0, 162.0, 161.0, 162.0, 164.0, 165.0, 170.0, 169.0, 164.0], "value": 164.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 88.0, 76.0, 156.0, 77.0, 76.0, 74.0, 85.0, 98.0, 76.0], "value": 88.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 79.0, 126.0, 79.0, 82.0, 78.0, 126.0, 79.0, 78.0, 128.0], "value": 93.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 114.0, 113.0, 117.0, 116.0, 118.0, 115.0, 115.0, 115.0, 115.0], "value": 115.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 149.0, 149.0, 149.0, 150.0, 150.0, 150.0, 150.0, 150.0, 151.0], "value": 149.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 95.0, 95.0, 93.0, 93.0, 95.0, 99.0, 96.0, 95.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 60.0, 53.0, 53.0, 54.0, 57.0, 55.0, 59.0, 51.0, 54.0], "value": 55.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 54.0, 54.0, 54.0, 61.0, 55.0, 58.0, 54.0, 54.0, 56.0], "value": 55.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 77.0, 79.0, 76.0, 81.0, 82.0, 79.0, 76.0, 79.0, 82.0], "value": 79.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [123.0, 130.0, 127.0, 125.0, 118.0, 126.0, 127.0, 129.0, 123.0, 158.0], "value": 128.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [178.0, 181.0, 179.0, 186.0, 180.0, 178.0, 176.0, 178.0, 175.0, 185.0], "value": 179.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 72.0, 71.0, 67.0, 66.0, 69.0, 70.0, 71.0, 69.0, 71.0], "value": 69.7, "unit": "score"}]}]} 17:55:03 INFO - Return code: 0 17:55:03 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 17:55:03 INFO - # TBPL SUCCESS # 17:55:03 INFO - Running post-action listener: _package_coverage_data 17:55:03 INFO - Running post-action listener: _resource_record_post_action 17:55:03 INFO - [mozharness: 2017-08-22 00:55:03.465753Z] Finished run-tests step (success) 17:55:03 INFO - Running post-run listener: _resource_record_post_run 17:55:03 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 4096; Write bytes: 436367360; Read time: 4; Write time: 481964 17:55:03 INFO - TinderboxPrint: CPU usage
13.2% 17:55:03 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 4 17:55:03 INFO - TinderboxPrint: I/O write bytes / time
436,367,360 / 481,964 17:55:03 INFO - TinderboxPrint: CPU idle
8,249.1 (86.8%) 17:55:03 INFO - TinderboxPrint: CPU user
1,200.8 (12.6%) 17:55:03 INFO - TinderboxPrint: Swap in / out
0 / 0 17:55:03 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 106717184; Read time: 0; Write time: 140460 17:55:03 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 17:55:03 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 0; Write bytes: 329650176; Read time: 0; Write time: 341504 17:55:04 INFO - Running post-run listener: _upload_blobber_files 17:55:04 INFO - Blob upload gear active. 17:55:04 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:55:04 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 17:55:04 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'] 17:55:04 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 17:55:04 INFO - (blobuploader) - INFO - Open directory for files ... 17:55:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 17:55:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:55:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:55:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 17:55:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:55:05 INFO - (blobuploader) - INFO - Done attempting. 17:55:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 17:55:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:55:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:55:06 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 17:55:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:55:06 INFO - (blobuploader) - INFO - Done attempting. 17:55:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 17:55:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:55:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:55:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 17:55:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:55:07 INFO - (blobuploader) - INFO - Done attempting. 17:55:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 17:55:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:55:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:55:10 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 17:55:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:55:10 INFO - (blobuploader) - INFO - Done attempting. 17:55:10 INFO - (blobuploader) - INFO - Iteration through files over. 17:55:10 INFO - Return code: 0 17:55:10 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:55:10 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:55:10 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d8dbade976de0ea9698d54da773cad100fdd320de859ddca6ffe31ff57f18da3080cf1b323f489d8fb93134b042d97641a96b3243f9b052a529c0831f63dcddb", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ee130fd70516cf73f75bffed20c2058c88033eb671a90956b59c26ea24bf5924b80458d979c111f500e5693944e3174f60c7e52861cfda04ae70968111d1a522", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bfbb51f9d81e8dad4340348610e24650d9af156313b8329d1bfa382fcbd4520917fa32993c97655ab794573f0cc2037ede0598597dda3c52b30914d5686f1065", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/108012a5ea8a7c9d93969c1146ebdd7496b1ef08eada22c726e122f02dd15756a1197c18254fa818f097b341d6defbb6de03ae89e203d588d0caca66d7741c11"} 17:55:10 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:55:10 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:55:10 INFO - Contents: 17:55:10 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d8dbade976de0ea9698d54da773cad100fdd320de859ddca6ffe31ff57f18da3080cf1b323f489d8fb93134b042d97641a96b3243f9b052a529c0831f63dcddb", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ee130fd70516cf73f75bffed20c2058c88033eb671a90956b59c26ea24bf5924b80458d979c111f500e5693944e3174f60c7e52861cfda04ae70968111d1a522", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bfbb51f9d81e8dad4340348610e24650d9af156313b8329d1bfa382fcbd4520917fa32993c97655ab794573f0cc2037ede0598597dda3c52b30914d5686f1065", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/108012a5ea8a7c9d93969c1146ebdd7496b1ef08eada22c726e122f02dd15756a1197c18254fa818f097b341d6defbb6de03ae89e203d588d0caca66d7741c11"} 17:55:10 INFO - Running post-run listener: copy_logs_to_upload_dir 17:55:10 INFO - Copying logs to upload dir... 17:55:10 INFO - mkdir: /builds/slave/test/build/upload/logs 17:55:10 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1250.595677 ========= master_lag: -0.39 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2017-08-21 17:55:10.053386) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-21 17:55:10.061204) ========= 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=c6927cf182745ad25b1d38b9000001fe-1503362057.505580-1623270300 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/d8dbade976de0ea9698d54da773cad100fdd320de859ddca6ffe31ff57f18da3080cf1b323f489d8fb93134b042d97641a96b3243f9b052a529c0831f63dcddb", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ee130fd70516cf73f75bffed20c2058c88033eb671a90956b59c26ea24bf5924b80458d979c111f500e5693944e3174f60c7e52861cfda04ae70968111d1a522", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bfbb51f9d81e8dad4340348610e24650d9af156313b8329d1bfa382fcbd4520917fa32993c97655ab794573f0cc2037ede0598597dda3c52b30914d5686f1065", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/108012a5ea8a7c9d93969c1146ebdd7496b1ef08eada22c726e122f02dd15756a1197c18254fa818f097b341d6defbb6de03ae89e203d588d0caca66d7741c11"} build_url:https://queue.taskcluster.net/v1/task/FkdMd0HTQmiwzY-YzIEfag/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011315 build_url: 'https://queue.taskcluster.net/v1/task/FkdMd0HTQmiwzY-YzIEfag/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d8dbade976de0ea9698d54da773cad100fdd320de859ddca6ffe31ff57f18da3080cf1b323f489d8fb93134b042d97641a96b3243f9b052a529c0831f63dcddb", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ee130fd70516cf73f75bffed20c2058c88033eb671a90956b59c26ea24bf5924b80458d979c111f500e5693944e3174f60c7e52861cfda04ae70968111d1a522", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bfbb51f9d81e8dad4340348610e24650d9af156313b8329d1bfa382fcbd4520917fa32993c97655ab794573f0cc2037ede0598597dda3c52b30914d5686f1065", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/108012a5ea8a7c9d93969c1146ebdd7496b1ef08eada22c726e122f02dd15756a1197c18254fa818f097b341d6defbb6de03ae89e203d588d0caca66d7741c11"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-21 17:55:10.093630) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-21 17:55:10.100026) ========= 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=c6927cf182745ad25b1d38b9000001fe-1503362057.505580-1623270300 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004441 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-21 17:55:10.149719) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-21 17:55:10.150037) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-21 17:55:10.150375) ========= ========= Total master_lag: -0.26 =========