builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-043 starttime: 1503101430.56 results: success (0) revision: 4f4487cc2d30d988742109868dcf21c4113f12f5 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-08-18 17:10:30.557953) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-08-18 17:10:30.558400) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-18 17:10:30.558677) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-18 17:10:30.575791) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-18 17:10:30.576120) ========= 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=d2a8c569965ab8367867b893000001a1-1503101429.438516-1988113263 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-08-18 17:10:30-- 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% 46.9M=0s 2017-08-18 17:10:30 (46.9 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.195660 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-18 17:10:30.804824) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-18 17:10:30.805138) ========= 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=d2a8c569965ab8367867b893000001a1-1503101429.438516-1988113263 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016699 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-18 17:10:30.854158) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-08-18 17:10:30.854488) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 4f4487cc2d30d988742109868dcf21c4113f12f5 --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 4f4487cc2d30d988742109868dcf21c4113f12f5 --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=d2a8c569965ab8367867b893000001a1-1503101429.438516-1988113263 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-08-18 17:10:30,900 truncating revision to first 12 chars 2017-08-18 17:10:30,900 Setting DEBUG logging. 2017-08-18 17:10:30,900 attempt 1/10 2017-08-18 17:10:30,900 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/4f4487cc2d30?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-08-18 17:10:32,226 unpacking tar archive at: mozilla-central-4f4487cc2d30/testing/mozharness/ program finished with exit code 0 elapsedTime=1.674185 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-08-18 17:10:32.543826) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-18 17:10:32.544223) ========= script_repo_revision: 4f4487cc2d30d988742109868dcf21c4113f12f5 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-18 17:10:32.544672) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-18 17:10:32.544987) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-18 17:10:32.556867) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2017-08-18 17:10:32.557176) ========= /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=d2a8c569965ab8367867b893000001a1-1503101429.438516-1988113263 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:10:32 INFO - MultiFileLogger online at 20170818 17:10:32 in /builds/slave/test 17:10:32 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:10:32 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:10:32 INFO - {'append_to_log': False, 17:10:32 INFO - 'base_work_dir': '/builds/slave/test', 17:10:32 INFO - 'blob_upload_branch': 'Firefox', 17:10:32 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:10:32 INFO - 'branch': 'Firefox', 17:10:32 INFO - 'buildbot_json_path': 'buildprops.json', 17:10:32 INFO - 'code_coverage': False, 17:10:32 INFO - 'config_files': ('talos/linux_config.py',), 17:10:32 INFO - 'default_actions': ('clobber', 17:10:32 INFO - 'read-buildbot-config', 17:10:32 INFO - 'download-and-extract', 17:10:32 INFO - 'populate-webroot', 17:10:32 INFO - 'create-virtualenv', 17:10:32 INFO - 'install', 17:10:32 INFO - 'setup-mitmproxy', 17:10:32 INFO - 'run-tests'), 17:10:32 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:10:32 INFO - 'disable_ccov_upload': False, 17:10:32 INFO - 'download_minidump_stackwalk': True, 17:10:32 INFO - 'download_symbols': 'ondemand', 17:10:32 INFO - 'enable_stylo': False, 17:10:32 INFO - 'enable_webrender': False, 17:10:32 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:10:32 INFO - 'tooltool.py': '/tools/tooltool.py', 17:10:32 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:10:32 INFO - '/tools/misc-python/virtualenv.py')}, 17:10:32 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:10:32 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:10:32 INFO - 'gecko_profile': False, 17:10:32 INFO - 'gecko_profile_interval': 0, 17:10:32 INFO - 'installer_path': 'installer.exe', 17:10:32 INFO - 'log_level': 'info', 17:10:32 INFO - 'log_name': 'talos', 17:10:32 INFO - 'log_to_console': True, 17:10:32 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:10:32 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:10:32 INFO - 'opt_config_files': (), 17:10:32 INFO - 'pip_index': False, 17:10:32 INFO - 'suite': 'dromaeojs-e10s', 17:10:32 INFO - 'system_bits': '32', 17:10:32 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:10:32 INFO - 'title': 'talos-linux64-ix-043', 17:10:32 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:10:32 INFO - 'use_talos_json': True, 17:10:32 INFO - 'verify': 'False', 17:10:32 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:10:32 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:10:32 INFO - 'work_dir': 'build'} 17:10:32 INFO - [mozharness: 2017-08-19 00:10:32.834361Z] Running clobber step. 17:10:32 INFO - Running pre-action listener: _resource_record_pre_action 17:10:32 INFO - Running main action method: clobber 17:10:32 INFO - rmtree: /builds/slave/test/build 17:10:32 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:10:33 INFO - Running post-action listener: _resource_record_post_action 17:10:33 INFO - [mozharness: 2017-08-19 00:10:33.817676Z] Finished clobber step (success) 17:10:33 INFO - [mozharness: 2017-08-19 00:10:33.817772Z] Running read-buildbot-config step. 17:10:33 INFO - Running pre-action listener: _resource_record_pre_action 17:10:33 INFO - Running main action method: read_buildbot_config 17:10:33 INFO - Using buildbot properties: 17:10:33 INFO - { 17:10:33 INFO - "project": "", 17:10:33 INFO - "product": "firefox", 17:10:33 INFO - "who": "kwierso@gmail.com", 17:10:33 INFO - "installer_path": "public/build/target.tar.bz2", 17:10:33 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 17:10:33 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 17:10:33 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 17:10:33 INFO - "stage_platform": "linux64-pgo", 17:10:33 INFO - "basedir": "/builds/slave/test", 17:10:33 INFO - "buildnumber": 129, 17:10:33 INFO - "platform": "ubuntu64_hw", 17:10:33 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 17:10:33 INFO - "slavebuilddir": "test", 17:10:33 INFO - "taskId": "W5JgABdxSvG4a9RhClDouw", 17:10:33 INFO - "branch": "mozilla-central", 17:10:33 INFO - "script_repo_revision": "production", 17:10:33 INFO - "revision": "4f4487cc2d30d988742109868dcf21c4113f12f5", 17:10:33 INFO - "slavename": "talos-linux64-ix-043", 17:10:33 INFO - "repo_path": "mozilla-central" 17:10:33 INFO - } 17:10:33 INFO - Finding installer, test and symbols from parent task. 17:10:33 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/W5JgABdxSvG4a9RhClDouw'}, attempt #1 17:10:34 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/W5JgABdxSvG4a9RhClDouw'}, attempt #1 17:10:34 INFO - Task dependencies: XPyRaK6FQe2kUwGj0OMW5Q 17:10:34 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/XPyRaK6FQe2kUwGj0OMW5Q'}, attempt #1 17:10:35 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/XPyRaK6FQe2kUwGj0OMW5Q/artifacts/public/build/target.tar.bz2 17:10:35 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/XPyRaK6FQe2kUwGj0OMW5Q/artifacts/public/build/target.test_packages.json 17:10:35 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/XPyRaK6FQe2kUwGj0OMW5Q/artifacts/public/build/target.crashreporter-symbols.zip 17:10:35 INFO - Running post-action listener: _resource_record_post_action 17:10:35 INFO - [mozharness: 2017-08-19 00:10:35.207620Z] Finished read-buildbot-config step (success) 17:10:35 INFO - [mozharness: 2017-08-19 00:10:35.207836Z] Running download-and-extract step. 17:10:35 INFO - Running pre-action listener: _resource_record_pre_action 17:10:35 INFO - Running main action method: download_and_extract 17:10:35 INFO - mkdir: /builds/slave/test/build/tests 17:10:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:10:35 INFO - trying https://queue.taskcluster.net/v1/task/XPyRaK6FQe2kUwGj0OMW5Q/artifacts/public/build/target.test_packages.json 17:10:35 INFO - Downloading https://queue.taskcluster.net/v1/task/XPyRaK6FQe2kUwGj0OMW5Q/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 17:10:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/XPyRaK6FQe2kUwGj0OMW5Q/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 17:10:35 INFO - Downloaded 989 bytes. 17:10:35 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 17:10:35 INFO - Using the following test package requirements: 17:10:35 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 17:10:35 INFO - u'common': [u'target.common.tests.zip'], 17:10:35 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 17:10:35 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 17:10:35 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 17:10:35 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 17:10:35 INFO - u'mozbase': [u'target.common.tests.zip'], 17:10:35 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 17:10:35 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 17:10:35 INFO - u'web-platform': [u'target.common.tests.zip', 17:10:35 INFO - u'target.web-platform.tests.tar.gz'], 17:10:35 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 17:10:35 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 17:10:35 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/XPyRaK6FQe2kUwGj0OMW5Q/artifacts/public/build/target.common.tests.zip 17:10:35 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/XPyRaK6FQe2kUwGj0OMW5Q/artifacts/public/build/target.common.tests.zip'}, attempt #1 17:10:35 INFO - Fetch https://queue.taskcluster.net/v1/task/XPyRaK6FQe2kUwGj0OMW5Q/artifacts/public/build/target.common.tests.zip into memory 17:10:36 INFO - Content-Length response header: 54619627 17:10:36 INFO - Bytes received: 54619627 17:10:48 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 17:10:48 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/XPyRaK6FQe2kUwGj0OMW5Q/artifacts/public/build/target.common.tests.zip 17:10:48 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/XPyRaK6FQe2kUwGj0OMW5Q/artifacts/public/build/target.common.tests.zip'}, attempt #1 17:10:48 INFO - Fetch https://queue.taskcluster.net/v1/task/XPyRaK6FQe2kUwGj0OMW5Q/artifacts/public/build/target.common.tests.zip into memory 17:10:49 INFO - Content-Length response header: 54619627 17:10:49 INFO - Bytes received: 54619627 17:11:01 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/XPyRaK6FQe2kUwGj0OMW5Q/artifacts/public/build/target.talos.tests.zip 17:11:01 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/XPyRaK6FQe2kUwGj0OMW5Q/artifacts/public/build/target.talos.tests.zip'}, attempt #1 17:11:01 INFO - Fetch https://queue.taskcluster.net/v1/task/XPyRaK6FQe2kUwGj0OMW5Q/artifacts/public/build/target.talos.tests.zip into memory 17:11:02 INFO - Content-Length response header: 14496256 17:11:02 INFO - Bytes received: 14496256 17:11:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:11:02 INFO - trying https://queue.taskcluster.net/v1/task/XPyRaK6FQe2kUwGj0OMW5Q/artifacts/public/build/target.tar.bz2 17:11:02 INFO - Downloading https://queue.taskcluster.net/v1/task/XPyRaK6FQe2kUwGj0OMW5Q/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 17:11:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/XPyRaK6FQe2kUwGj0OMW5Q/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 17:11:03 INFO - Downloaded 63260952 bytes. 17:11:03 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/XPyRaK6FQe2kUwGj0OMW5Q/artifacts/public/build/target.tar.bz2 17:11:03 INFO - mkdir: /builds/slave/test/properties 17:11:03 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:11:03 INFO - Writing to file /builds/slave/test/properties/build_url 17:11:03 INFO - Contents: 17:11:03 INFO - build_url:https://queue.taskcluster.net/v1/task/XPyRaK6FQe2kUwGj0OMW5Q/artifacts/public/build/target.tar.bz2 17:11:03 INFO - Running post-action listener: _resource_record_post_action 17:11:03 INFO - Running post-action listener: find_tests_for_verification 17:11:03 INFO - Running post-action listener: set_extra_try_arguments 17:11:03 INFO - [mozharness: 2017-08-19 00:11:03.494236Z] Finished download-and-extract step (success) 17:11:03 INFO - [mozharness: 2017-08-19 00:11:03.494332Z] Running populate-webroot step. 17:11:03 INFO - Running pre-action listener: _resource_record_pre_action 17:11:03 INFO - Running main action method: populate_webroot 17:11:03 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:11:03 INFO - 'chromez-stylo-e10s': {'talos_options': ['--stylo'], 17:11:03 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:11:03 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:11:03 INFO - 'dromaeojs-stylo-e10s': {'talos_options': ['--stylo'], 17:11:03 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:11:03 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 17:11:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:11:03 INFO - 'g1-stylo-e10s': {'pagesets_name': 'tp5n.zip', 17:11:03 INFO - 'talos_options': ['--stylo'], 17:11:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:11:03 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 17:11:03 INFO - 'tests': ['damp', 'tps']}, 17:11:03 INFO - 'g2-stylo-e10s': {'pagesets_name': 'tp5n.zip', 17:11:03 INFO - 'talos_options': ['--stylo'], 17:11:03 INFO - 'tests': ['damp', 'tps']}, 17:11:03 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:11:03 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 17:11:03 INFO - 'g4-stylo-e10s': {'talos_options': ['--stylo'], 17:11:03 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 17:11:03 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 17:11:03 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 17:11:03 INFO - 'g5-stylo-e10s': {'pagesets_name': 'tp5n.zip', 17:11:03 INFO - 'talos_options': ['--stylo'], 17:11:03 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 17:11:03 INFO - 'other-e10s': {'tests': ['a11yr', 17:11:03 INFO - 'ts_paint', 17:11:03 INFO - 'tpaint', 17:11:03 INFO - 'sessionrestore', 17:11:03 INFO - 'sessionrestore_many_windows', 17:11:03 INFO - 'sessionrestore_no_auto_restore', 17:11:03 INFO - 'tabpaint']}, 17:11:03 INFO - 'other-stylo-e10s': {'talos_options': ['--stylo'], 17:11:03 INFO - 'tests': ['a11yr', 17:11:03 INFO - 'ts_paint', 17:11:03 INFO - 'tpaint', 17:11:03 INFO - 'sessionrestore', 17:11:03 INFO - 'sessionrestore_many_windows', 17:11:03 INFO - 'sessionrestore_no_auto_restore', 17:11:03 INFO - 'tabpaint']}, 17:11:03 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 17:11:03 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 17:11:03 INFO - 'perf-reftest-singletons-stylo-e10s': {'talos_options': ['--stylo'], 17:11:03 INFO - 'tests': ['bloom_basic_singleton']}, 17:11:03 INFO - 'perf-reftest-stylo-e10s': {'talos_options': ['--stylo'], 17:11:03 INFO - 'tests': ['bloom_basic']}, 17:11:03 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:11:03 INFO - 'tsvgr_opacity', 17:11:03 INFO - 'tart', 17:11:03 INFO - 'tscrollx', 17:11:03 INFO - 'tsvg_static']}, 17:11:03 INFO - 'svgr-stylo-e10s': {'talos_options': ['--stylo'], 17:11:03 INFO - 'tests': ['tsvgx', 17:11:03 INFO - 'tsvgr_opacity', 17:11:03 INFO - 'tart', 17:11:03 INFO - 'tscrollx', 17:11:03 INFO - 'tsvg_static']}, 17:11:03 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 17:11:03 INFO - 'tp5o-stylo-e10s': {'pagesets_name': 'tp5n.zip', 17:11:03 INFO - 'talos_options': ['--stylo'], 17:11:03 INFO - 'tests': ['tp5o']}, 17:11:03 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 17:11:03 INFO - 'talos_options': ['--mitmproxy', 17:11:03 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 17:11:03 INFO - '--firstNonBlankPaint'], 17:11:03 INFO - 'tests': ['tp6_google', 17:11:03 INFO - 'tp6_youtube', 17:11:03 INFO - 'tp6_amazon', 17:11:03 INFO - 'tp6_facebook']}, 17:11:03 INFO - 'tp6-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 17:11:03 INFO - 'talos_options': ['--stylo', 17:11:03 INFO - '--mitmproxy', 17:11:03 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 17:11:03 INFO - '--firstNonBlankPaint'], 17:11:03 INFO - 'tests': ['tp6_google', 17:11:03 INFO - 'tp6_youtube', 17:11:03 INFO - 'tp6_amazon', 17:11:03 INFO - 'tp6_facebook']}, 17:11:03 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 17:11:03 INFO - 'talos_options': ['--stylo', 17:11:03 INFO - '--stylo-threads=1', 17:11:03 INFO - '--mitmproxy', 17:11:03 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 17:11:03 INFO - '--firstNonBlankPaint'], 17:11:03 INFO - 'tests': ['tp6_google', 17:11:03 INFO - 'tp6_youtube', 17:11:03 INFO - 'tp6_amazon', 17:11:03 INFO - 'tp6_facebook']}, 17:11:03 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 17:11:03 INFO - 'talos_options': ['--xperf_path', 17:11:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:11:03 INFO - 'tests': ['tp5n']}, 17:11:03 INFO - 'xperf-stylo-e10s': {'pagesets_name': 'tp5n.zip', 17:11:03 INFO - 'talos_options': ['--stylo', 17:11:03 INFO - '--xperf_path', 17:11:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:11:03 INFO - 'tests': ['tp5n']}}} 17:11:03 INFO - Running post-action listener: _resource_record_post_action 17:11:03 INFO - [mozharness: 2017-08-19 00:11:03.510669Z] Finished populate-webroot step (success) 17:11:03 INFO - [mozharness: 2017-08-19 00:11:03.510796Z] Running create-virtualenv step. 17:11:03 INFO - Running pre-action listener: _resource_record_pre_action 17:11:03 INFO - Running main action method: create_virtualenv 17:11:03 INFO - Creating virtualenv /builds/slave/test/build/venv 17:11:03 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:11:03 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:11:03 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 17:11:03 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:11:03 INFO - Using real prefix '/usr' 17:11:03 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:11:04 INFO - Installing distribute.............................................................................................................................................................................................done. 17:11:06 INFO - Installing pip.................done. 17:11:06 INFO - Return code: 0 17:11:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 17:11:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 17:11:06 INFO - Reading from file tmpfile_stdout 17:11:06 INFO - Output received: 17:11:06 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:11:06 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:11:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:11:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:11:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:11:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:11:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xbd11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd9ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf3ff90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf3d130>, '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 0xf3e030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf3e4c0>, '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': 'd2a8c569965ab8367867b893000001a1-1503101429.438516-1988113263', '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:11:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 17:11:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 17:11:06 INFO - Using env: {'DISPLAY': ':0', 17:11:06 INFO - 'HOME': '/home/cltbld', 17:11:06 INFO - 'LANG': 'en_US.UTF-8', 17:11:06 INFO - 'LANGUAGE': 'en_US:en', 17:11:06 INFO - 'LOGNAME': 'cltbld', 17:11:06 INFO - 'MAIL': '/var/mail/cltbld', 17:11:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:11:06 INFO - 'MOZ_NO_REMOTE': '1', 17:11:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:11:06 INFO - 'NO_EM_RESTART': '1', 17:11:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:11:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:11:06 INFO - 'PWD': '/builds/slave/test', 17:11:06 INFO - 'SHELL': '/bin/bash', 17:11:06 INFO - 'SHLVL': '1', 17:11:06 INFO - 'TERM': 'linux', 17:11:06 INFO - 'TMOUT': '86400', 17:11:06 INFO - 'USER': 'cltbld', 17:11:06 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1503101429.438516-1988113263', 17:11:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:11:06 INFO - '_': '/tools/buildbot/bin/python'} 17:11:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:11:06 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:11:06 INFO - Cleaning up... 17:11:06 INFO - Return code: 0 17:11:06 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 17:11:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:11:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:11:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:11:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:11:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xbd11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd9ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf3ff90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf3d130>, '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 0xf3e030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf3e4c0>, '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': 'd2a8c569965ab8367867b893000001a1-1503101429.438516-1988113263', '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:11:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 17:11:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 17:11:06 INFO - Using env: {'DISPLAY': ':0', 17:11:06 INFO - 'HOME': '/home/cltbld', 17:11:06 INFO - 'LANG': 'en_US.UTF-8', 17:11:06 INFO - 'LANGUAGE': 'en_US:en', 17:11:06 INFO - 'LOGNAME': 'cltbld', 17:11:06 INFO - 'MAIL': '/var/mail/cltbld', 17:11:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:11:06 INFO - 'MOZ_NO_REMOTE': '1', 17:11:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:11:06 INFO - 'NO_EM_RESTART': '1', 17:11:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:11:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:11:06 INFO - 'PWD': '/builds/slave/test', 17:11:06 INFO - 'SHELL': '/bin/bash', 17:11:06 INFO - 'SHLVL': '1', 17:11:06 INFO - 'TERM': 'linux', 17:11:06 INFO - 'TMOUT': '86400', 17:11:06 INFO - 'USER': 'cltbld', 17:11:06 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1503101429.438516-1988113263', 17:11:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:11:06 INFO - '_': '/tools/buildbot/bin/python'} 17:11:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:11:07 INFO - Downloading/unpacking psutil>=3.1.1 17:11:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:11:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:11:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:11:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:11:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:11:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:11:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:11:08 INFO - Installing collected packages: psutil 17:11:08 INFO - Running setup.py install for psutil 17:11:08 INFO - building 'psutil._psutil_linux' extension 17:11:08 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:11:09 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:11:09 INFO - building 'psutil._psutil_posix' extension 17:11:09 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:11:09 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:11:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:11:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:11:09 INFO - Successfully installed psutil 17:11:09 INFO - Cleaning up... 17:11:09 INFO - Return code: 0 17:11:09 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 17:11:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:11:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:11:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:11:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:11:09 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 0xbd11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd9ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf3ff90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf3d130>, '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 0xf3e030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf3e4c0>, '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': 'd2a8c569965ab8367867b893000001a1-1503101429.438516-1988113263', '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:11:09 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:11:09 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:11:09 INFO - Using env: {'DISPLAY': ':0', 17:11:09 INFO - 'HOME': '/home/cltbld', 17:11:09 INFO - 'LANG': 'en_US.UTF-8', 17:11:09 INFO - 'LANGUAGE': 'en_US:en', 17:11:09 INFO - 'LOGNAME': 'cltbld', 17:11:09 INFO - 'MAIL': '/var/mail/cltbld', 17:11:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:11:09 INFO - 'MOZ_NO_REMOTE': '1', 17:11:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:11:09 INFO - 'NO_EM_RESTART': '1', 17:11:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:11:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:11:09 INFO - 'PWD': '/builds/slave/test', 17:11:09 INFO - 'SHELL': '/bin/bash', 17:11:09 INFO - 'SHLVL': '1', 17:11:09 INFO - 'TERM': 'linux', 17:11:09 INFO - 'TMOUT': '86400', 17:11:09 INFO - 'USER': 'cltbld', 17:11:09 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1503101429.438516-1988113263', 17:11:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:11:09 INFO - '_': '/tools/buildbot/bin/python'} 17:11:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:11:09 INFO - Downloading/unpacking mozsystemmonitor==0.3 17:11:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:11:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:11:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:11:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:11:11 INFO - Downloading mozsystemmonitor-0.3.tar.gz 17:11:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:11:11 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 17:11:11 INFO - Installing collected packages: mozsystemmonitor 17:11:11 INFO - Running setup.py install for mozsystemmonitor 17:11:11 INFO - Successfully installed mozsystemmonitor 17:11:11 INFO - Cleaning up... 17:11:11 INFO - Return code: 0 17:11:11 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 17:11:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:11:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:11:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:11:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:11:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xbd11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd9ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf3ff90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf3d130>, '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 0xf3e030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf3e4c0>, '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': 'd2a8c569965ab8367867b893000001a1-1503101429.438516-1988113263', '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:11:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 17:11:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 17:11:11 INFO - Using env: {'DISPLAY': ':0', 17:11:11 INFO - 'HOME': '/home/cltbld', 17:11:11 INFO - 'LANG': 'en_US.UTF-8', 17:11:11 INFO - 'LANGUAGE': 'en_US:en', 17:11:11 INFO - 'LOGNAME': 'cltbld', 17:11:11 INFO - 'MAIL': '/var/mail/cltbld', 17:11:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:11:11 INFO - 'MOZ_NO_REMOTE': '1', 17:11:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:11:11 INFO - 'NO_EM_RESTART': '1', 17:11:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:11:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:11:11 INFO - 'PWD': '/builds/slave/test', 17:11:11 INFO - 'SHELL': '/bin/bash', 17:11:11 INFO - 'SHLVL': '1', 17:11:11 INFO - 'TERM': 'linux', 17:11:11 INFO - 'TMOUT': '86400', 17:11:11 INFO - 'USER': 'cltbld', 17:11:11 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1503101429.438516-1988113263', 17:11:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:11:11 INFO - '_': '/tools/buildbot/bin/python'} 17:11:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:11:11 INFO - Downloading/unpacking jsonschema==2.5.1 17:11:11 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:11:11 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:11:11 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:11:11 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:11:12 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:11:12 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 17:11:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:11:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:11:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:11:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:11:12 INFO - Downloading functools32-3.2.3-2.tar.gz 17:11:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:11:12 INFO - warning: no files found matching '*.txt' 17:11:12 INFO - no previously-included directories found matching 'build' 17:11:12 INFO - no previously-included directories found matching 'dist' 17:11:12 INFO - no previously-included directories found matching '.git*' 17:11:12 INFO - Installing collected packages: jsonschema, functools32 17:11:12 INFO - Running setup.py install for functools32 17:11:12 INFO - warning: no files found matching '*.txt' 17:11:12 INFO - no previously-included directories found matching 'build' 17:11:12 INFO - no previously-included directories found matching 'dist' 17:11:12 INFO - no previously-included directories found matching '.git*' 17:11:12 INFO - Successfully installed jsonschema functools32 17:11:12 INFO - Cleaning up... 17:11:12 INFO - Return code: 0 17:11:12 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 17:11:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:11:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:11:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:11:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:11:12 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 0xbd11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd9ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf3ff90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf3d130>, '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 0xf3e030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf3e4c0>, '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': 'd2a8c569965ab8367867b893000001a1-1503101429.438516-1988113263', '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:11:12 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:11:12 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:11:12 INFO - Using env: {'DISPLAY': ':0', 17:11:12 INFO - 'HOME': '/home/cltbld', 17:11:12 INFO - 'LANG': 'en_US.UTF-8', 17:11:12 INFO - 'LANGUAGE': 'en_US:en', 17:11:12 INFO - 'LOGNAME': 'cltbld', 17:11:12 INFO - 'MAIL': '/var/mail/cltbld', 17:11:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:11:12 INFO - 'MOZ_NO_REMOTE': '1', 17:11:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:11:12 INFO - 'NO_EM_RESTART': '1', 17:11:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:11:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:11:12 INFO - 'PWD': '/builds/slave/test', 17:11:12 INFO - 'SHELL': '/bin/bash', 17:11:12 INFO - 'SHLVL': '1', 17:11:12 INFO - 'TERM': 'linux', 17:11:12 INFO - 'TMOUT': '86400', 17:11:12 INFO - 'USER': 'cltbld', 17:11:12 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1503101429.438516-1988113263', 17:11:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:11:12 INFO - '_': '/tools/buildbot/bin/python'} 17:11:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:11:13 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 17:11:13 INFO - Cleaning up... 17:11:13 INFO - Return code: 0 17:11:13 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:11:13 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:11:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:11:13 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:11:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:11:13 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 0xbd11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd9ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf3ff90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf3d130>, '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 0xf3e030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf3e4c0>, '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': 'd2a8c569965ab8367867b893000001a1-1503101429.438516-1988113263', '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:11:13 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:11:13 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:11:13 INFO - Using env: {'DISPLAY': ':0', 17:11:13 INFO - 'HOME': '/home/cltbld', 17:11:13 INFO - 'LANG': 'en_US.UTF-8', 17:11:13 INFO - 'LANGUAGE': 'en_US:en', 17:11:13 INFO - 'LOGNAME': 'cltbld', 17:11:13 INFO - 'MAIL': '/var/mail/cltbld', 17:11:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:11:13 INFO - 'MOZ_NO_REMOTE': '1', 17:11:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:11:13 INFO - 'NO_EM_RESTART': '1', 17:11:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:11:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:11:13 INFO - 'PWD': '/builds/slave/test', 17:11:13 INFO - 'SHELL': '/bin/bash', 17:11:13 INFO - 'SHLVL': '1', 17:11:13 INFO - 'TERM': 'linux', 17:11:13 INFO - 'TMOUT': '86400', 17:11:13 INFO - 'USER': 'cltbld', 17:11:13 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1503101429.438516-1988113263', 17:11:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:11:13 INFO - '_': '/tools/buildbot/bin/python'} 17:11:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:11:13 INFO - Downloading/unpacking blobuploader==1.2.4 17:11:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:11:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:11:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:11:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:11:14 INFO - Downloading blobuploader-1.2.4.tar.gz 17:11:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:11:14 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:11:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:11:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:11:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:11:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:11:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:11:14 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:11:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:11:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:11:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:11:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:11:15 INFO - Downloading docopt-0.6.1.tar.gz 17:11:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:11:15 INFO - Installing collected packages: blobuploader, requests, docopt 17:11:15 INFO - Running setup.py install for blobuploader 17:11:15 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:11:15 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:11:15 INFO - Running setup.py install for requests 17:11:15 INFO - Running setup.py install for docopt 17:11:15 INFO - Successfully installed blobuploader requests docopt 17:11:15 INFO - Cleaning up... 17:11:15 INFO - Return code: 0 17:11:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:11:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:11:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:11:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:11:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:11:15 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 0xbd11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd9ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf3ff90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf3d130>, '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 0xf3e030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf3e4c0>, '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': 'd2a8c569965ab8367867b893000001a1-1503101429.438516-1988113263', '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:11:15 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:11:15 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:11:15 INFO - Using env: {'DISPLAY': ':0', 17:11:15 INFO - 'HOME': '/home/cltbld', 17:11:15 INFO - 'LANG': 'en_US.UTF-8', 17:11:15 INFO - 'LANGUAGE': 'en_US:en', 17:11:15 INFO - 'LOGNAME': 'cltbld', 17:11:15 INFO - 'MAIL': '/var/mail/cltbld', 17:11:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:11:15 INFO - 'MOZ_NO_REMOTE': '1', 17:11:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:11:15 INFO - 'NO_EM_RESTART': '1', 17:11:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:11:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:11:15 INFO - 'PWD': '/builds/slave/test', 17:11:15 INFO - 'SHELL': '/bin/bash', 17:11:15 INFO - 'SHLVL': '1', 17:11:15 INFO - 'TERM': 'linux', 17:11:15 INFO - 'TMOUT': '86400', 17:11:15 INFO - 'USER': 'cltbld', 17:11:15 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1503101429.438516-1988113263', 17:11:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:11:15 INFO - '_': '/tools/buildbot/bin/python'} 17:11:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:11:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:11:15 INFO - Running setup.py (path:/tmp/pip-BiD5s3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:11:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:11:15 INFO - Running setup.py (path:/tmp/pip-NDdo_4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:11:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:11:16 INFO - Running setup.py (path:/tmp/pip-UOHhzV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:11:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:11:16 INFO - Running setup.py (path:/tmp/pip-4RHLMt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:11:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:11:16 INFO - Running setup.py (path:/tmp/pip-klEVcP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:11:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:11:16 INFO - Running setup.py (path:/tmp/pip-IxHp7c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:11:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:11:16 INFO - Running setup.py (path:/tmp/pip-ndQD0Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:11:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:11:16 INFO - Running setup.py (path:/tmp/pip-oBtkA_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:11:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:11:16 INFO - Running setup.py (path:/tmp/pip-CmmFr5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:11:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:11:16 INFO - Running setup.py (path:/tmp/pip-qv4hd8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:11:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:11:16 INFO - Running setup.py (path:/tmp/pip-P8P9Vz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:11:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:11:16 INFO - Running setup.py (path:/tmp/pip-e6JUUS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:11:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:11:16 INFO - Running setup.py (path:/tmp/pip-snztMS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:11:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:11:16 INFO - Running setup.py (path:/tmp/pip-3trxyW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:11:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:11:16 INFO - Running setup.py (path:/tmp/pip-M6i2EY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:11:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:11:16 INFO - Running setup.py (path:/tmp/pip-eMSm2q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:11:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:11:17 INFO - Running setup.py (path:/tmp/pip-UPe8Gz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:11:17 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:11:17 INFO - Running setup.py install for manifestparser 17:11:17 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:11:17 INFO - Running setup.py install for mozcrash 17:11:17 INFO - Running setup.py install for mozdebug 17:11:17 INFO - Running setup.py install for mozdevice 17:11:17 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:11:17 INFO - Running setup.py install for mozfile 17:11:17 INFO - Running setup.py install for mozhttpd 17:11:17 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:11:17 INFO - Running setup.py install for mozinfo 17:11:17 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:11:17 INFO - Running setup.py install for mozInstall 17:11:17 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:11:17 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:11:17 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:11:17 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:11:17 INFO - Running setup.py install for mozleak 17:11:17 INFO - Running setup.py install for mozlog 17:11:18 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:11:18 INFO - Running setup.py install for moznetwork 17:11:18 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:11:18 INFO - Running setup.py install for mozprocess 17:11:18 INFO - Running setup.py install for mozprofile 17:11:18 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:11:18 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:11:18 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:11:18 INFO - Running setup.py install for mozrunner 17:11:18 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:11:18 INFO - Running setup.py install for mozscreenshot 17:11:18 INFO - Running setup.py install for moztest 17:11:18 INFO - Running setup.py install for mozversion 17:11:18 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:11:18 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:11:18 INFO - Cleaning up... 17:11:18 INFO - Return code: 0 17:11:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:11:18 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:11:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:11:18 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:11:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:11:18 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 0xbd11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd9ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf3ff90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf3d130>, '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 0xf3e030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf3e4c0>, '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': 'd2a8c569965ab8367867b893000001a1-1503101429.438516-1988113263', '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:11:18 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:11:18 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:11:18 INFO - Using env: {'DISPLAY': ':0', 17:11:18 INFO - 'HOME': '/home/cltbld', 17:11:18 INFO - 'LANG': 'en_US.UTF-8', 17:11:18 INFO - 'LANGUAGE': 'en_US:en', 17:11:18 INFO - 'LOGNAME': 'cltbld', 17:11:18 INFO - 'MAIL': '/var/mail/cltbld', 17:11:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:11:18 INFO - 'MOZ_NO_REMOTE': '1', 17:11:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:11:18 INFO - 'NO_EM_RESTART': '1', 17:11:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:11:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:11:18 INFO - 'PWD': '/builds/slave/test', 17:11:18 INFO - 'SHELL': '/bin/bash', 17:11:18 INFO - 'SHLVL': '1', 17:11:18 INFO - 'TERM': 'linux', 17:11:18 INFO - 'TMOUT': '86400', 17:11:18 INFO - 'USER': 'cltbld', 17:11:18 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1503101429.438516-1988113263', 17:11:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:11:18 INFO - '_': '/tools/buildbot/bin/python'} 17:11:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:11:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:11:19 INFO - Running setup.py (path:/tmp/pip-WKXP41-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:11:19 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:11:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:11:19 INFO - Running setup.py (path:/tmp/pip-FLyuMX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:11:19 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:11:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:11:19 INFO - Running setup.py (path:/tmp/pip-d_VO_N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:11:19 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:11:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:11:19 INFO - Running setup.py (path:/tmp/pip-VLHjSr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:11:19 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:11:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:11:19 INFO - Running setup.py (path:/tmp/pip-WBobW1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:11:19 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:11:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:11:19 INFO - Running setup.py (path:/tmp/pip-8vEY3a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:11:19 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:11:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:11:19 INFO - Running setup.py (path:/tmp/pip-7SCNM6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:11:19 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:11:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:11:19 INFO - Running setup.py (path:/tmp/pip-aLRI1a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:11:19 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:11:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:11:19 INFO - Running setup.py (path:/tmp/pip-Em6oDk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:11:19 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:11:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:11:19 INFO - Running setup.py (path:/tmp/pip-hc9JzC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:11:19 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:11:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:11:19 INFO - Running setup.py (path:/tmp/pip-RHYbqu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:11:19 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:11:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:11:19 INFO - Running setup.py (path:/tmp/pip-skP5ux-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:11:20 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:11:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:11:20 INFO - Running setup.py (path:/tmp/pip-xu9S_s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:11:20 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:11:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:11:20 INFO - Running setup.py (path:/tmp/pip-9hxyDh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:11:20 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:11:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:11:20 INFO - Running setup.py (path:/tmp/pip-CPl95S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:11:20 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:11:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:11:20 INFO - Running setup.py (path:/tmp/pip-mwh62q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:11:20 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:11:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:11:20 INFO - Running setup.py (path:/tmp/pip-hLKo7h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:11:20 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:11:20 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:11:20 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:11:20 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:11:20 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:11:20 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:11:20 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:11:20 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:11:20 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:11:20 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:11:20 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:11:20 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:11:21 INFO - Downloading blessings-1.6.tar.gz 17:11:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:11:21 INFO - Installing collected packages: blessings 17:11:21 INFO - Running setup.py install for blessings 17:11:21 INFO - Successfully installed blessings 17:11:21 INFO - Cleaning up... 17:11:21 INFO - Return code: 0 17:11:21 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:11:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:11:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:11:21 INFO - Reading from file tmpfile_stdout 17:11:21 INFO - Current package versions: 17:11:21 INFO - argparse == 1.2.1 17:11:21 INFO - blessings == 1.6 17:11:21 INFO - blobuploader == 1.2.4 17:11:21 INFO - docopt == 0.6.1 17:11:21 INFO - functools32 == 3.2.3-2 17:11:21 INFO - jsonschema == 2.5.1 17:11:21 INFO - manifestparser == 1.1 17:11:21 INFO - mozInstall == 1.13 17:11:21 INFO - mozcrash == 1.0 17:11:21 INFO - mozdebug == 0.1 17:11:21 INFO - mozdevice == 0.51 17:11:21 INFO - mozfile == 1.2 17:11:21 INFO - mozhttpd == 0.7 17:11:21 INFO - mozinfo == 0.10 17:11:21 INFO - mozleak == 0.1 17:11:21 INFO - mozlog == 3.5 17:11:21 INFO - moznetwork == 0.27 17:11:21 INFO - mozprocess == 0.25 17:11:21 INFO - mozprofile == 0.28 17:11:21 INFO - mozrunner == 6.13 17:11:21 INFO - mozscreenshot == 0.1 17:11:21 INFO - mozsystemmonitor == 0.3 17:11:21 INFO - moztest == 0.8 17:11:21 INFO - mozversion == 1.4 17:11:21 INFO - psutil == 3.1.1 17:11:21 INFO - requests == 1.2.3 17:11:21 INFO - wsgiref == 0.1.2 17:11:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:11:21 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:11:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:11:21 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:11:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:11:21 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 0xbd11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd9ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf3ff90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf3d130>, '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 0xf3e030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf3e4c0>, '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': 'd2a8c569965ab8367867b893000001a1-1503101429.438516-1988113263', '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:11:21 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:11:21 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:11:21 INFO - Using env: {'DISPLAY': ':0', 17:11:21 INFO - 'HOME': '/home/cltbld', 17:11:21 INFO - 'LANG': 'en_US.UTF-8', 17:11:21 INFO - 'LANGUAGE': 'en_US:en', 17:11:21 INFO - 'LOGNAME': 'cltbld', 17:11:21 INFO - 'MAIL': '/var/mail/cltbld', 17:11:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:11:21 INFO - 'MOZ_NO_REMOTE': '1', 17:11:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:11:21 INFO - 'NO_EM_RESTART': '1', 17:11:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:11:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:11:21 INFO - 'PWD': '/builds/slave/test', 17:11:21 INFO - 'SHELL': '/bin/bash', 17:11:21 INFO - 'SHLVL': '1', 17:11:21 INFO - 'TERM': 'linux', 17:11:21 INFO - 'TMOUT': '86400', 17:11:21 INFO - 'USER': 'cltbld', 17:11:21 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1503101429.438516-1988113263', 17:11:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:11:21 INFO - '_': '/tools/buildbot/bin/python'} 17:11:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:11:22 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:11:22 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:11:22 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:11:22 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:11:22 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:11:22 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:11:22 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:11:22 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:11:22 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:11:22 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 17:11:22 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:11:22 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:11:22 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:11:22 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:11:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 17:11:23 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:11:23 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:11:23 INFO - Installing collected packages: simplejson 17:11:23 INFO - Running setup.py install for simplejson 17:11:23 INFO - building 'simplejson._speedups' extension 17:11:23 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:11:24 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:11:24 INFO - Successfully installed simplejson 17:11:24 INFO - Cleaning up... 17:11:24 INFO - Return code: 0 17:11:24 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:11:24 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:11:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:11:24 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:11:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:11:24 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 0xbd11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd9ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf3ff90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf3d130>, '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 0xf3e030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf3e4c0>, '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': 'd2a8c569965ab8367867b893000001a1-1503101429.438516-1988113263', '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:11:24 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:11:24 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:11:24 INFO - Using env: {'DISPLAY': ':0', 17:11:24 INFO - 'HOME': '/home/cltbld', 17:11:24 INFO - 'LANG': 'en_US.UTF-8', 17:11:24 INFO - 'LANGUAGE': 'en_US:en', 17:11:24 INFO - 'LOGNAME': 'cltbld', 17:11:24 INFO - 'MAIL': '/var/mail/cltbld', 17:11:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:11:24 INFO - 'MOZ_NO_REMOTE': '1', 17:11:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:11:24 INFO - 'NO_EM_RESTART': '1', 17:11:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:11:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:11:24 INFO - 'PWD': '/builds/slave/test', 17:11:24 INFO - 'SHELL': '/bin/bash', 17:11:24 INFO - 'SHLVL': '1', 17:11:24 INFO - 'TERM': 'linux', 17:11:24 INFO - 'TMOUT': '86400', 17:11:24 INFO - 'USER': 'cltbld', 17:11:24 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1503101429.438516-1988113263', 17:11:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:11:24 INFO - '_': '/tools/buildbot/bin/python'} 17:11:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:11:24 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 17:11:24 INFO - Cleaning up... 17:11:24 INFO - Return code: 0 17:11:24 INFO - Running post-action listener: _resource_record_post_action 17:11:24 INFO - Running post-action listener: _start_resource_monitoring 17:11:24 INFO - Starting resource monitoring. 17:11:24 INFO - [mozharness: 2017-08-19 00:11:24.772462Z] Finished create-virtualenv step (success) 17:11:24 INFO - [mozharness: 2017-08-19 00:11:24.773394Z] Running install step. 17:11:24 INFO - Running pre-action listener: _resource_record_pre_action 17:11:24 INFO - Running main action method: install 17:11:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:11:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:11:24 INFO - Reading from file tmpfile_stdout 17:11:24 INFO - Detecting whether we're running mozinstall >=1.0... 17:11:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:11:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:11:25 INFO - Reading from file tmpfile_stdout 17:11:25 INFO - Output received: 17:11:25 INFO - Usage: mozinstall [options] installer 17:11:25 INFO - Options: 17:11:25 INFO - -h, --help show this help message and exit 17:11:25 INFO - -d DEST, --destination=DEST 17:11:25 INFO - Directory to install application into. [default: 17:11:25 INFO - "/builds/slave/test"] 17:11:25 INFO - --app=APP Application being installed. [default: firefox] 17:11:25 INFO - mkdir: /builds/slave/test/build/application 17:11:25 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:11:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 17:11:42 INFO - Reading from file tmpfile_stdout 17:11:42 INFO - Output received: 17:11:42 INFO - /builds/slave/test/build/application/firefox/firefox 17:11:42 INFO - Running post-action listener: _resource_record_post_action 17:11:42 INFO - [mozharness: 2017-08-19 00:11:42.977100Z] Finished install step (success) 17:11:42 INFO - [mozharness: 2017-08-19 00:11:42.977381Z] Running setup-mitmproxy step. 17:11:42 INFO - Running pre-action listener: _resource_record_pre_action 17:11:42 INFO - Running main action method: setup_mitmproxy 17:11:42 INFO - Skipping: mitmproxy is not required 17:11:42 INFO - Running post-action listener: _resource_record_post_action 17:11:42 INFO - [mozharness: 2017-08-19 00:11:42.978522Z] Finished setup-mitmproxy step (success) 17:11:42 INFO - [mozharness: 2017-08-19 00:11:42.978739Z] Running run-tests step. 17:11:42 INFO - Running pre-action listener: _resource_record_pre_action 17:11:42 INFO - Running pre-action listener: _set_gcov_prefix 17:11:42 INFO - Running main action method: run_tests 17:11:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:11:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:11:42 INFO - Python 2.7.3 17:11:42 INFO - Return code: 0 17:11:42 INFO - grabbing minidump binary from tooltool 17:11:42 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:11:42 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 0xf3d130>, '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 0xf3e030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf3e4c0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:11:42 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:11:42 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:11:42 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:11:43 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:11:43 INFO - Return code: 0 17:11:43 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 17:11:43 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:11:43 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:11:43 INFO - ENV: RUST_BACKTRACE is now full 17:11:43 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 17:11:43 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:11:43 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/XPyRaK6FQe2kUwGj0OMW5Q/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-043', '--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:11:43 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/XPyRaK6FQe2kUwGj0OMW5Q/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-043 --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:11:43 INFO - Using env: {'DISPLAY': ':0', 17:11:43 INFO - 'HOME': '/home/cltbld', 17:11:43 INFO - 'LANG': 'en_US.UTF-8', 17:11:43 INFO - 'LANGUAGE': 'en_US:en', 17:11:43 INFO - 'LOGNAME': 'cltbld', 17:11:43 INFO - 'MAIL': '/var/mail/cltbld', 17:11:43 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:11:43 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:11:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:11:43 INFO - 'MOZ_NO_REMOTE': '1', 17:11:43 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:11:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:11:43 INFO - 'NO_EM_RESTART': '1', 17:11:43 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:11:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:11:43 INFO - 'PWD': '/builds/slave/test', 17:11:43 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:11:43 INFO - 'RUST_BACKTRACE': 'full', 17:11:43 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 17:11:43 INFO - 'SHELL': '/bin/bash', 17:11:43 INFO - 'SHLVL': '1', 17:11:43 INFO - 'TERM': 'linux', 17:11:43 INFO - 'TMOUT': '86400', 17:11:43 INFO - 'USER': 'cltbld', 17:11:43 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1503101429.438516-1988113263', 17:11:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:11:43 INFO - '_': '/tools/buildbot/bin/python'} 17:11:43 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/XPyRaK6FQe2kUwGj0OMW5Q/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-043', '--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:11:43 INFO - mozversion application_buildid: 20170818225328 17:11:43 INFO - mozversion application_changeset: 4f4487cc2d30d988742109868dcf21c4113f12f5 17:11:43 INFO - mozversion application_display_name: Nightly 17:11:43 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:11:43 INFO - mozversion application_name: Firefox 17:11:43 INFO - mozversion application_remotingname: firefox 17:11:43 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 17:11:43 INFO - mozversion application_vendor: Mozilla 17:11:43 INFO - mozversion application_version: 57.0a1 17:11:43 INFO - mozversion platform_buildid: 20170818225328 17:11:43 INFO - mozversion platform_changeset: 4f4487cc2d30d988742109868dcf21c4113f12f5 17:11:43 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 17:11:43 INFO - mozversion platform_version: 57.0a1 17:11:43 INFO - using testdate: 1503101503 17:11:43 INFO - actual date: 1503101503 17:11:43 INFO - starting webserver on 'localhost:34476' 17:11:43 INFO - SUITE-START | Running 2 tests 17:11:43 INFO - TEST-START | dromaeo_css 17:11:43 INFO - Initialising browser for dromaeo_css test... 17:11:43 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:34476/getInfo.html -profile /tmp/tmpi2hvka/profile 17:11:43 INFO - TEST-INFO | started process 3340 (/builds/slave/test/build/application/firefox/firefox http://localhost:34476/getInfo.html) 17:11:52 INFO - TEST-INFO | 3340: exit 0 17:11:52 INFO - Browser initialized. 17:11:52 INFO - Running cycle 1/1 for dromaeo_css test... 17:11:52 INFO - TEST-INFO | started process 3560 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpi2hvka/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 17:11:53 INFO - PID 3560 | 17:11:53 INFO - PID 3560 | (/builds/slave/test/build/application/firefox/firefox:3609): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 17:11:53 INFO - PID 3560 | 17:11:53 INFO - PID 3560 | 17:11:53 INFO - PID 3560 | (/builds/slave/test/build/application/firefox/firefox:3668): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 17:11:53 INFO - PID 3560 | 17:11:54 INFO - PID 3560 | __metrics Screen width/height:1600/1200 17:11:54 INFO - PID 3560 | colorDepth:24 17:11:54 INFO - PID 3560 | Browser inner width/height: 1024/768 17:11:54 INFO - PID 3560 | __metrics 17:12:03 INFO - PID 3560 | RSS: Main: 165265408 17:12:03 INFO - PID 3560 | 17:15:01 INFO - PID 3560 | Cycle 1(1): loaded http://localhost:34476/tests/dromaeo/cssquery-dojo.html (next: http://localhost:34476/tests/dromaeo/cssquery-ext.html) 17:15:02 INFO - PID 3560 | RSS: Main: 170057728 17:15:02 INFO - PID 3560 | 17:18:04 INFO - PID 3560 | Cycle 1(1): loaded http://localhost:34476/tests/dromaeo/cssquery-ext.html (next: http://localhost:34476/tests/dromaeo/cssquery-jquery.html) 17:18:05 INFO - PID 3560 | RSS: Main: 166768640 17:18:05 INFO - PID 3560 | 17:21:06 INFO - PID 3560 | Cycle 1(1): loaded http://localhost:34476/tests/dromaeo/cssquery-jquery.html (next: http://localhost:34476/tests/dromaeo/cssquery-mootools.html) 17:21:07 INFO - PID 3560 | RSS: Main: 169672704 17:21:07 INFO - PID 3560 | 17:24:08 INFO - PID 3560 | Cycle 1(1): loaded http://localhost:34476/tests/dromaeo/cssquery-mootools.html (next: http://localhost:34476/tests/dromaeo/cssquery-prototype.html) 17:24:09 INFO - PID 3560 | RSS: Main: 166641664 17:24:09 INFO - PID 3560 | 17:27:12 INFO - PID 3560 | Cycle 1(1): loaded http://localhost:34476/tests/dromaeo/cssquery-prototype.html (next: http://localhost:34476/tests/dromaeo/cssquery-yui.html) 17:27:13 INFO - PID 3560 | RSS: Main: 168710144 17:27:13 INFO - PID 3560 | 17:30:14 INFO - PID 3560 | Cycle 1(1): loaded http://localhost:34476/tests/dromaeo/cssquery-yui.html (next: http://localhost:34476/tests/dromaeo/cssquery-dojo.html) 17:30:15 INFO - PID 3560 | RSS: Main: 170725376 17:30:15 INFO - PID 3560 | 17:30:15 INFO - PID 3560 | __start_tp_report 17:30:15 INFO - PID 3560 | _x_x_mozilla_page_load 17:30:15 INFO - PID 3560 | _x_x_mozilla_page_load_details 17:30:15 INFO - PID 3560 | |i|pagename|runs| 17:30:15 INFO - PID 3560 | |0;dojo.html;3482.912927176822;3503.824808759561;3541.9114522136933;3544.308859772344;3554.253606742584;6156.753729850806;6294.905576416346;6302.590331628441;6307.148534947781;6358.109864618957;6176.567640265183;6285.434310912017;6291.245050593924;6302.212223472066;6306.274778400485;5477.4796394342475;5503.3120859892515;5554.361248456418;5600.887982240352;5606.6636001839815;5538.6122971392015;5610.747516361774;5617.41017193195;5634.746436410372;5667.348254950672;5428.647137936041;5476.91784623231;5541.861453463655;5571.8885622287735;5639.859003524924;5547.44525547442;5556.444355564452;5587.664740115606;5625.099984002581;5633.380328163898;5532.170174473821;5535.474129957688;5561.805336813232;5592.105263157916;5611.438856114397;6082.9695851520455;6212.65830379329;6236.87526249477;6239.844003899939;6288.371162883721;6751.864962700768;6765.154355705537;6780.220274668378;6792.218894827109;6801.4558835293055;6819.283975182584;6846.657667116624;6862.622555759432;6873.072135261776;6873.656317184121;6244.6253224806205;6318.557700960934;6323.20959880015;6327;6343.777967771106;7012.368886800213;7057.258987806206;7076.256993015762;7086.716531338792;7092.290770922969;6693.732250709917;6697.330266973361;6740.662966851638;6777.322267773282;6792.150981127359;6687.063811066455;6731.326867313327;6783.321667833177;6801.319868013159;6917;6760.864782704417;6762.357576030269;6765.8646827063185;6786.524943254023;6793.694283757144;6809.148856392951;6851.931480685229;6884.690188941509;6886.51794374399;6915.308469153045;4831.178699621073;4893.559579637849;4924.236743304794;4928.950710492849;4938.975305123451;4322.805473753689;4325.480942286946;4346.587074227943;4361.9127617447475;4462.553744625511;6509.316521765241;6519.152510173742;6549.050387693757;6569.047488114196;6570.934290657128;6768.627725475048;6871.9656401717675;6920.204176519765;6931.34152255545;6934.861302773917;6311.33730958252;6417.358264173638;6436.292007879129;6515.8696826063215;6544.607323560602;5437.374701909252;5501.477359650827;5514.641548299348;5532.917006244909;5533.778648854081;7131.607761573163;7132.322429369202;7209.71161153548;7218.530795498275;7231.349178573849;6813.488988325995;6814.625195614289;6847.144106986527;6884.139482564679;6906.343897329745;6937.583744975116;7007.6145811978795;7009.264027277062;7022;7023.613701246481;6688.297728738413;6704;6775.86448271022;6776.356246156607;6823.454123670193;6871.931280687129;6887.173539175131;6919.238883722685;6938.236793952762;6948.930510694829;6567.408933196035;6574.309697481695;6623.304553021863;6655.833604159935;6688.531802773759;6449.5485316027425;6568.343165683585;6572.572782769296;6574.572652777745;6580.5064620152725;6486.254080780771;6568.310327415744;6624.304448032887;6642.202935647753;6700.430463410665;6666.166729158856;6715.4963377747845;6730.427913627396;6737.461003119836;6753.0883330751685;6466.0947467355545;6528.67356632176;6529.542931994714;6551.541392102507;6559.376859198369 17:30:15 INFO - PID 3560 | |1;ext.html;863.3731294385186;898.0346127912492;932.5337331334333;935.5322338830584;945.0455040409189;40805.183896322094;41636.583634163646;41710;41730.791346043305;41748.58251417489;39297.41053884194;39445.40831887524;39470.21059578807;39556.80221598895;39887.60112398875;6863.828404289883;6981.720731170747;6982.615956122411;6987.615681137536;6987.650617469106;6930.5841649500935;6987.475939304547;6988.825279368031;6997.825054373656;7004.824879378006;7484.476086673935;7567.394608431312;7592.240775922419;7603.771886843404;7605.6577454014705;7507.4369422293275;7528.849423011564;7531.171571127172;7549.962250188769;7564.281393267658;7396;7397.963010184914;7524.435667324972;7530.209328020588;7536.5101268417375;39067;39516.407253891215;39523.20953580941;39532.407013894815;39592;3439.724822014233;3467.7745946513396;3468.0289518934737;3474.513568100468;3485.268093700326;30479.085627431214;30674;30675.69324306773;30740.53889191664;30741.692583074106;5025.924611130836;5048.924266136011;5062.417821950486;5072.72100034498;5092.032513822362;206788.9999999985;206979;207599;208460;208748;50307;50501;50564.74717626462;50658.24012639813;50666.493335066916;52438.213426798626;52577;52616.736916315174;52650.21024684633;52681;16601.41895033668;17076.060816654954;17132.571685707706;17135;17137.485875423758;13862.792058119136;13876.653083672989;13907.09603875765;13973.231472269123;13974;14909.403623854925;14912.925435372754;14955.327010284345;15027.924860375628;15286.464973725866;5798.681072540966;5905.527557795452;5948;6029;6035.517158627299;1040.0327695243345;1075.800976819291;1076.4994277660926;1076.8115579773507;1086.4784903246486;24597.38506537315;24698.753012469646;24894.626580601307;24899.377515562257;24956.875215623804;1172.9296242225494;1173.636172786439;1176.300101439642;1180.321315243721;1182.562451892788;12840.101192916407;13021.609351719464;13100.475980960655;13106.475740970445;13244.933775331061;274432;274913;275075;275906;276091;54286.72856635691;54813.451865481635;58058;58241;58596.41403585995;1485.5172069077594;1500.1473180621924;1503.4211828446128;1525;1525.6109692028463;28913.855430722713;29180.7081929178;29232.269193269487;29527;30006.699933001262;38756.6124338753;38806.2238755229;38811.805940971244;38850;38875.80562097171;218971;219144;219298;219616;219935;33226.833865830515;34244;34351.65648343485;34357.312853743286;34359.31281374308;42291.36562951496;42907.570924290354;43458.78270608627;43478;43670.56329436665;32477.18807029843;32901.50647740238;32988;33075.83462082674;33385;33050.504242436866;33252.33495330128;33341.83329083339;33682;33709;37725.811370944066;37894.8105259483;37984.81007595055;38074.23851523009;38123.046923827125;31896.840515797274;31933;31942.36115277635;31971.520427193147;32154.83922580372;23580.855779406105;23825.642615361132;24598.407598827136;24732;25032 17:30:15 INFO - PID 3560 | |2;jquery.html;567.1351189436109;576.6857062900717;577.3504807092022;578.7164289498147;593.8426317025989;22327.888360558194;22636.094556217773;23030.539389212227;23091.307260782163;23156.189533366334;26039.609405858926;26425.20724378267;26515.86742066292;26674.73325266747;26715.332116697093;6218.22272215973;6348.047792831089;6360.300366959631;6364.649944253064;6369.426751592356;5809.244798176232;6041.486473649745;6069.089636554508;6100.633961962297;6105.877882442349;6080.391960803929;6084;6084.939150608481;6086.087086936951;6086.452219300262;6067.302260240085;6074.726637301332;6078.088286756978;6080.118382834465;6082.057281121433;5645.661260324394;5646.943530564683;5677.602567820254;5683.914741278884;5688.345840228385;29788.40423191524;29954.25114372158;30098.398032039455;30597.541036884464;30641.540376894365;2137.9893100534396;2201.4276288165033;2204.713387259662;2205.117952818869;2205.4596623827106;19823.80176198234;20338.28815991448;20351.69472457914;20383.796162038485;20385.796142038536;2213.690083388327;2442.926712198637;2484.35406794233;2530.051230788454;2530.367408147963;155929;159515;159577.20211398986;160117;160166.99999999884;14957.476488322856;15598.376064957274;15655.060696358254;15763.68472630541;16065.759013614805;23285.650715239284;23416.53166936652;23544.17595384153;23586.64620030701;24033.27900162998;10785.892141078646;10909.072728818139;10999.450027498593;11009.779804403866;11197.552097916156;10143.137833284105;10181.592736290466;10285.22860785444;10296.485175741333;10355.585776569003;9798.167155791694;9891.664625275496;9906.900930990741;9960.203183745283;10132;2712.5795501697266;2767.3081729567607;2773.9181719129556;2800.3559181387986;2834.929126771847;1038.1850247555783;1039.0544604409952;1062.3667058659403;1065.0255016659669;1077.8868218837067;21154.15383384678;21683.56632867334;21710.674339884914;21988.34034978921;22101.889490552767;1131.9943400282946;1134.387430787382;1135.392564977733;1140.2303445174473;1144.8855114488485;11601;12025.819612705816;12038.87961120395;12155.149139560146;12230.327331996825;541205;584232;586208;605833;606877;126114.36942815228;127710;129838.35080824724;131502.34248828696;131866;1226.3316492511603;1254.8243245945575;1275.1201670847086;1280.2830414967834;1280.9167404118703;18860.528486787392;18896.149673265012;19215.231390744215;19293.228270869007;19585;61585;61871;61905;63590.68204658947;64878;76214.61892690501;76338.23661763311;76348.61825690836;77214;77324.61337693276;14445.205513696848;14897.404103835725;14996.100233985995;15263;15501.457448989231;24866.75133248717;24915;25292.241232763048;25897.352566185997;25988.740112598633;20256;20532.486687832923;20946.47633809167;21044.894775526638;21078;18144;18420;18450.446486605422;18887.622247554697;18953.52616184551;19664.311749088713;20201.393958181277;20230.59538809245;21506.462338441037;21782.346529604136;14996.2501874908;15067.849321506645;15120.319585618894;15255.542333730005;15352.462663806713;19781.505462363555;19989.700154497987;20038.398848034583;20121.094550744958;20184.091715872528 17:30:15 INFO - PID 3560 | |3;mootools.html;1486.450013495007;1505.9759363632731;1539.1611571693427;1549.6978089272588;1552.6061246671927;15350.385984560618;15941.123238221893;15982.360705571764;15983.520494385188;16027.118508482028;15757.84242157578;16217.91891040546;16913.7462938056;16917.7462338065;16925.407610733626;2720.782337413002;2753.105240796739;2755.0632784853146;2757.379589592346;2757.420941602266;2531.2153232497894;2596.156249219002;2627.106783693544;2664.653595032643;2723.101376545745;2593.792496600277;2606.7262937391583;2626.3171575390443;2626.921192364232;2628.027629776985;2552.5660637691453;2552.8468291902454;2557.8337408068414;2561.820672552922;2604.322876052221;2599.727028662001;2625.474905019004;2629.855357955312;2677.0897894715695;2678.3571942733797;15972.920135399365;16076.196190190443;16078;16079.517614471584;16086.195690215442;7898.80252993674;8136.552489613069;8147.837043259102;8151.796205094861;8157.877631835528;5047.268146118829;5181.171012637998;5257.947420525784;5302.708351040691;5377.085895397791;1806.4219449776076;1844.1424737497127;1855.0817345414107;1896.9146388412555;1899.7625296837896;27827.443451131065;27997.300067498476;28053.158405247672;28054.579181312296;28078.43843123126;6778;6798.388145066968;6831.795046148623;6979.406750426169;6997.93002069983;18756.812431875507;18770.436886893414;18788.71816922747;18796;18818.341358052676;7745.651445684957;8034.1564135766075;8036.276735093869;8037.35701143907;8037.799055023671;7353.889691654629;7383;7464.962675186589;7476.5514069156025;7480.438967077491;4867.367242258554;4997.0505603935135;5062.493750624908;5063.392392912874;5098.923516147261;1426.86444787745;1477.3868844429655;1699.6175860431551;1769.4691592522192;1771.4242871066954;976.2921881635757;995.7012896131276;996.3772642098688;1000.3597697473623;1019.0013786489134;9212.63149474027;9229.077092290852;9305.813883722287;9423.10480504351;9427.19868811145;1060.4220699718517;1084.1651928015542;1091.4160923905672;1093.0708897437114;1103.6027030269097;5618.297712785902;5627.803026894039;5633.26767520228;5814.360420353758;5869.8239052828485;22582.661260081113;23553.293401197992;23587.41031474227;23617;23625.173118940755;22209.333719988426;22980.4254893629;23123.306300811004;23432.297031089096;23594.7640523596;12405.565805196775;12432.197331386898;12602.55891043809;12664.74670506603;12783.936080319725;8875.112488751074;8924.910750892668;8953.28373730087;8957.641694332153;9013.864792027995;20033.09851056735;20126.39620811378;20213;20243.696344554548;20346.89826550858;20134.59730805405;20166.193352265745;20213.59572808565;20225.79774202239;20426.591468170256;12870.742585148431;13159.407826648016;13171.736565268833;13230.536931207362;13261.138026028277;14286.785698214328;14408.351624176728;14525.636859078608;14750;14775.039622424509;11543.538258469567;11628.709282268012;11703.23928944616;11750.23623464472;11925.701857453632;11430.25703329281;11434;11552.422378880854;11773.411329433666;11848.526058957545;10325.173986080945;10339.638112666322;10445.791084178425;10446.634367797395;10449.373037617766;7838.137804841349;7991.320737737125;8022.638981245975;8027.8795818063945;8060.234277743605;8350.039745429354;8372.41393102477;8479.576021199038;8498.065212826461;8518.275946544365 17:30:15 INFO - PID 3560 | |4;prototype.html;528.5612941258755;530.8885134121836;538.0825692194808;542.7286356821589;544.8774025844185;6060.666663333521;6127.846803829906;6179.351168127349;6191.845203869905;6237.781677641277;6063.211782468284;6092.939070609293;6102.237220347457;6114.113453549244;6117.755289788403;4831.734254616003;4925.679830810986;4934.28452874333;4948.7773050212645;4949.777260023289;4672.742999135046;4789;4824.276358546229;4857.417109946811;4898.755062246892;4720.527947205286;4760.952390476085;4764.807578922113;4778.354922085508;4788.736619485927;4770.833020844254;4773.90452190956;4801.231802911552;4806.206975848981;4830.444498882638;4341.761203133827;4371.34429835524;4380.78096095194;4390.714603550791;4404.955950440487;5949.853376829055;6003.129546215818;6018.916595012896;6041.093835924603;6062.242219722535;5630.268065151545;5653.265075540195;5674.063779476382;5717.828465146053;5757.366689664133;6447.290798012262;6450.903236451457;6458.709358078898;6504.056911747817;6516.380943810331;4919.286703428019;4919.483454237289;4927.236278376858;4932.2108462646165;4940.925886111711;6483.416492515649;6597.80206593803;6707.228668703113;6734.764283250062;6834.863302733917;4957.529034741694;5008.447381311805;5027.572656324253;5054.191329387354;5077.8730531737;5100.566451851634;5115.232715092766;5140.717260550631;5147.433782283946;5158.638895277295;5682.715864206773;5694.174344720075;5707.315122185364;5723.368839880614;5754.136879468113;6460.903086453707;6509.804705858832;6530.249021362509;6582.967085164543;6605.471562275006;1758.1912320332535;1793.372319688125;1796.4700413378084;1800.6848801459691;1803.2696757813108;1194.952201911931;1232.896557580978;1243.570968016033;1263.6920786985427;1278.6483716977905;6244.46922011625;6281.371862813682;6284.685765711696;6284.905726414107;6298.181236439325;6547.705353259114;6586.5389422739945;6601.306862779339;6601.3728695773825;6614.239362473377;5987.730552125165;6109.725062372204;6124.38756124384;6170.907436388457;6184;3492.371373152806;3497.632748561364;3498.1254686328416;3515.3848076587005;3533.434650455915;6892.655367231619;6916.55042422241;6944.791656250321;7015.964920175468;7035.753748618774;6429.6465858432575;6766.221884483348;6838.965805170942;6851.383375496229;6902.482313826483;6941.791746247621;6952;6962.443004559623;6980.127484064492;6997.230304666483;6637.236717777518;6646.9151099409955;6665.900011499734;6667.599944003376;6689.632070236184;6607.372299631527;6609.405153536205;6622.536422450382;6650.933490665031;6658.7336506539195;7015.579065256101;7033.542819716907;7042.859142817218;7067.222605513492;7097.396721278749;5096.490350964874;5104.4129925057605;5104.489551044866;5119.206522988943;5132.9743351283005;6464;6602.7689030883685;6630.436412904764;6725.562838415487;6802.251752307143;6447.3552644735155;6496.285408604956;6510.772122975863;6527.281998980204;6540.50946179048;6458.870822583616;6468.579542329733;6495.545311828127;6496.6751662415745;6541;6430.3891130342545;6496.252930913006;6514.1531600891585;6519.576227545194;6551.410373066256;6472.608389196345;6554.8361290968105;6556.934430655632;6572.737090516326;6574.934250657432;6356.650384228912;6375.298717141018;6375.968120159369;6389.744410223725;6407.167068281094 17:30:15 INFO - PID 3560 | |5;yui.html;946.4415994563207;951.1012093571576;963.2577436658579;965.2229954886313;972.7227740094074;19643.214271429144;20337.18651253948;20354.491137721565;20355.796442035575;20371.796282037176;16687.415940442086;16870.915645421785;22476.550468990612;22501.21245756399;22543.774562254373;1055.4880882771868;1096.0245381610373;1096.0628662493573;1096.7916095941746;1098.0447011100314;1043.7286305560533;1081.686310969818;1105.9668209953675;1109.6005438042298;1110.1562812262657;1145.1811954452564;1150.959716409926;1151.2977083978767;1151.7869194199059;1153.5904753812401;1143.8055530559825;1144.250515912079;1144.4678224625588;1144.7596004838995;1144.9542018319257;840.64272684109;841.2680967558202;841.3059226138461;841.3984001439001;844;18369.265229390807;18643.067846607617;18719;18839.529011774815;19372.225110995543;22232.333030009126;22539.43651408728;22708.31875043735;22724;22801.77198228013;15862.36550537977;15962.361505539764;16027.278772455267;16093.919530402272;16098.195090245441;3766.6610005099674;3775.244951009809;3785.8107094645156;3792.2794669013074;3793.2603142387247;141812;142653.28673356568;143657;143662;144000.27999859935;16993.150342482826;17523.386681466087;17553.736693949602;17560.56098597545;17692.380766673363;32701.50947735786;33985;34007.4898876517;34161.487577686356;34205.828970854986;9065.138811813;9142.680006199751;9231.261499080058;9246.029166937375;9255.259579233645;4347.282698354736;4408.470983482002;4415.381846541422;4433.933490997638;4435.423394958635;5451.400345961941;5455.263539422127;5486.91769623456;5505.504504594525;5531.585131115102;1119.652907598647;1125.2573301620891;1134.2457265918072;1135.642272684102;1138.618562781461;725.3182008911606;744.7989042958371;748.2741740511694;760.7793739815392;765.6860687118254;12578.685532861751;13389.866101338863;13501.459941602423;14517.201553914425;14774.63063423423;723.0636325957897;726.5495392856462;727.1601300497828;736.7016358374867;736.8563130189561;5674.886502269931;5715.714214289352;5788.913166302509;6659.833504162338;7173.457706593107;136688;136959.31520342335;138389;139485;142252.28873855565;115997;116981.41509292398;119008.40495797465;120045;122445.38777306235;99747.50126249323;102399;105892;108721.45639271753;110396.44801776101;13793.724125517634;13813.378397971914;14083.577492675236;14646.121232726071;14734.336954836843;49344.50655493399;49702;49890;50019.499805001484;50607;82249.37118217713;85915;87634.56182719045;88146;90607;20273.695894561297;21233.15067397287;21245.6813147806;21260;21264.25575104864;21635.783642163376;21819.127234910426;22566.88716556407;23410.64884026707;23513.17703880356;20172.79827201709;20686.586268274852;21000.36998890036;21018.47453813667;21491.247806326704;18458.446246612624;18584.07079645985;18669.159887805352;18861.339853105077;19329.613407731485;20381.18475260973;20768.688469672667;20932.37202883916;21160.153593856074;21221.045052972346;14393.352299146354;14440.855591443951;14508.347124379217;14521.419143234152;14532.927335363256;16416.917915410348;16908.23912923946;17070.82929170742;17071.31714731397;17222.91388543049 17:30:15 INFO - PID 3560 | __end_tp_report 17:30:15 INFO - PID 3560 | __start_cc_report 17:30:15 INFO - PID 3560 | _x_x_mozilla_cycle_collect,334 17:30:15 INFO - PID 3560 | __end_cc_report 17:30:15 INFO - PID 3560 | __startTimestamp1503102615121__endTimestamp 17:30:15 INFO - PID 3560 | 17:30:15 INFO - PID 3560 | ------- Summary: start ------- 17:30:15 INFO - PID 3560 | Number of tests: 6 17:30:15 INFO - PID 3560 | 17:30:15 INFO - PID 3560 | [#0] dojo.html Cycles:165 Average:6263.47 Median:6568.34 stddev:817.21 (12.4%) stddev-sans-first:790.07 17:30:15 INFO - PID 3560 | Values: 3482.9 3503.8 3541.9 3544.3 3554.3 6156.8 6294.9 6302.6 6307.1 6358.1 6176.6 6285.4 6291.2 6302.2 6306.3 5477.5 5503.3 5554.4 5600.9 5606.7 5538.6 5610.7 5617.4 5634.7 5667.3 5428.6 5476.9 5541.9 5571.9 5639.9 5547.4 5556.4 5587.7 5625.1 5633.4 5532.2 5535.5 5561.8 5592.1 5611.4 6083.0 6212.7 6236.9 6239.8 6288.4 6751.9 6765.2 6780.2 6792.2 6801.5 6819.3 6846.7 6862.6 6873.1 6873.7 6244.6 6318.6 6323.2 6327.0 6343.8 7012.4 7057.3 7076.3 7086.7 7092.3 6693.7 6697.3 6740.7 6777.3 6792.2 6687.1 6731.3 6783.3 6801.3 6917.0 6760.9 6762.4 6765.9 6786.5 6793.7 6809.1 6851.9 6884.7 6886.5 6915.3 4831.2 4893.6 4924.2 4929.0 4939.0 4322.8 4325.5 4346.6 4361.9 4462.6 6509.3 6519.2 6549.1 6569.0 6570.9 6768.6 6872.0 6920.2 6931.3 6934.9 6311.3 6417.4 6436.3 6515.9 6544.6 5437.4 5501.5 5514.6 5532.9 5533.8 7131.6 7132.3 7209.7 7218.5 7231.3 6813.5 6814.6 6847.1 6884.1 6906.3 6937.6 7007.6 7009.3 7022.0 7023.6 6688.3 6704.0 6775.9 6776.4 6823.5 6871.9 6887.2 6919.2 6938.2 6948.9 6567.4 6574.3 6623.3 6655.8 6688.5 6449.5 6568.3 6572.6 6574.6 6580.5 6486.3 6568.3 6624.3 6642.2 6700.4 6666.2 6715.5 6730.4 6737.5 6753.1 6466.1 6528.7 6529.5 6551.5 6559.4 17:30:15 INFO - PID 3560 | 17:30:15 INFO - PID 3560 | [#1] ext.html Cycles:180 Average:40530.86 Median:3453.75 stddev:61351.78 (1776.4%) stddev-sans-first:61451.59 17:30:15 INFO - PID 3560 | Values: 863.4 898.0 932.5 935.5 945.0 40805.2 41636.6 41710.0 41730.8 41748.6 39297.4 39445.4 39470.2 39556.8 39887.6 6863.8 6981.7 6982.6 6987.6 6987.7 6930.6 6987.5 6988.8 6997.8 7004.8 7484.5 7567.4 7592.2 7603.8 7605.7 7507.4 7528.8 7531.2 7550.0 7564.3 7396.0 7398.0 7524.4 7530.2 7536.5 39067.0 39516.4 39523.2 39532.4 39592.0 3439.7 3467.8 3468.0 3474.5 3485.3 30479.1 30674.0 30675.7 30740.5 30741.7 5025.9 5048.9 5062.4 5072.7 5092.0 206789.0 206979.0 207599.0 208460.0 208748.0 50307.0 50501.0 50564.7 50658.2 50666.5 52438.2 52577.0 52616.7 52650.2 52681.0 16601.4 17076.1 17132.6 17135.0 17137.5 13862.8 13876.7 13907.1 13973.2 13974.0 14909.4 14912.9 14955.3 15027.9 15286.5 5798.7 5905.5 5948.0 6029.0 6035.5 1040.0 1075.8 1076.5 1076.8 1086.5 24597.4 24698.8 24894.6 24899.4 24956.9 1172.9 1173.6 1176.3 1180.3 1182.6 12840.1 13021.6 13100.5 13106.5 13244.9 274432.0 274913.0 275075.0 275906.0 276091.0 54286.7 54813.5 58058.0 58241.0 58596.4 1485.5 1500.1 1503.4 1525.0 1525.6 28913.9 29180.7 29232.3 29527.0 30006.7 38756.6 38806.2 38811.8 38850.0 38875.8 218971.0 219144.0 219298.0 219616.0 219935.0 33226.8 34244.0 34351.7 34357.3 34359.3 42291.4 42907.6 43458.8 43478.0 43670.6 32477.2 32901.5 32988.0 33075.8 33385.0 33050.5 33252.3 33341.8 33682.0 33709.0 37725.8 37894.8 37984.8 38074.2 38123.0 31896.8 31933.0 31942.4 31971.5 32154.8 23580.9 23825.6 24598.4 24732.0 25032.0 17:30:15 INFO - PID 3560 | 17:30:15 INFO - PID 3560 | [#2] jquery.html Cycles:180 Average:39252.58 Median:12094.88 stddev:98397.13 (813.5%) stddev-sans-first:98630.29 17:30:15 INFO - PID 3560 | Values: 567.1 576.7 577.4 578.7 593.8 22327.9 22636.1 23030.5 23091.3 23156.2 26039.6 26425.2 26515.9 26674.7 26715.3 6218.2 6348.0 6360.3 6364.6 6369.4 5809.2 6041.5 6069.1 6100.6 6105.9 6080.4 6084.0 6084.9 6086.1 6086.5 6067.3 6074.7 6078.1 6080.1 6082.1 5645.7 5646.9 5677.6 5683.9 5688.3 29788.4 29954.3 30098.4 30597.5 30641.5 2138.0 2201.4 2204.7 2205.1 2205.5 19823.8 20338.3 20351.7 20383.8 20385.8 2213.7 2442.9 2484.4 2530.1 2530.4 155929.0 159515.0 159577.2 160117.0 160167.0 14957.5 15598.4 15655.1 15763.7 16065.8 23285.7 23416.5 23544.2 23586.6 24033.3 10785.9 10909.1 10999.5 11009.8 11197.6 10143.1 10181.6 10285.2 10296.5 10355.6 9798.2 9891.7 9906.9 9960.2 10132.0 2712.6 2767.3 2773.9 2800.4 2834.9 1038.2 1039.1 1062.4 1065.0 1077.9 21154.2 21683.6 21710.7 21988.3 22101.9 1132.0 1134.4 1135.4 1140.2 1144.9 11601.0 12025.8 12038.9 12155.1 12230.3 541205.0 584232.0 586208.0 605833.0 606877.0 126114.4 127710.0 129838.4 131502.3 131866.0 1226.3 1254.8 1275.1 1280.3 1280.9 18860.5 18896.1 19215.2 19293.2 19585.0 61585.0 61871.0 61905.0 63590.7 64878.0 76214.6 76338.2 76348.6 77214.0 77324.6 14445.2 14897.4 14996.1 15263.0 15501.5 24866.8 24915.0 25292.2 25897.4 25988.7 20256.0 20532.5 20946.5 21044.9 21078.0 18144.0 18420.0 18450.4 18887.6 18953.5 19664.3 20201.4 20230.6 21506.5 21782.3 14996.3 15067.8 15120.3 15255.5 15352.5 19781.5 19989.7 20038.4 20121.1 20184.1 17:30:15 INFO - PID 3560 | 17:30:15 INFO - PID 3560 | [#3] mootools.html Cycles:180 Average:9929.72 Median:23621.09 stddev:7198.37 (30.5%) stddev-sans-first:7190.61 17:30:15 INFO - PID 3560 | Values: 1486.5 1506.0 1539.2 1549.7 1552.6 15350.4 15941.1 15982.4 15983.5 16027.1 15757.8 16217.9 16913.7 16917.7 16925.4 2720.8 2753.1 2755.1 2757.4 2757.4 2531.2 2596.2 2627.1 2664.7 2723.1 2593.8 2606.7 2626.3 2626.9 2628.0 2552.6 2552.8 2557.8 2561.8 2604.3 2599.7 2625.5 2629.9 2677.1 2678.4 15972.9 16076.2 16078.0 16079.5 16086.2 7898.8 8136.6 8147.8 8151.8 8157.9 5047.3 5181.2 5257.9 5302.7 5377.1 1806.4 1844.1 1855.1 1896.9 1899.8 27827.4 27997.3 28053.2 28054.6 28078.4 6778.0 6798.4 6831.8 6979.4 6997.9 18756.8 18770.4 18788.7 18796.0 18818.3 7745.7 8034.2 8036.3 8037.4 8037.8 7353.9 7383.0 7465.0 7476.6 7480.4 4867.4 4997.1 5062.5 5063.4 5098.9 1426.9 1477.4 1699.6 1769.5 1771.4 976.3 995.7 996.4 1000.4 1019.0 9212.6 9229.1 9305.8 9423.1 9427.2 1060.4 1084.2 1091.4 1093.1 1103.6 5618.3 5627.8 5633.3 5814.4 5869.8 22582.7 23553.3 23587.4 23617.0 23625.2 22209.3 22980.4 23123.3 23432.3 23594.8 12405.6 12432.2 12602.6 12664.7 12783.9 8875.1 8924.9 8953.3 8957.6 9013.9 20033.1 20126.4 20213.0 20243.7 20346.9 20134.6 20166.2 20213.6 20225.8 20426.6 12870.7 13159.4 13171.7 13230.5 13261.1 14286.8 14408.4 14525.6 14750.0 14775.0 11543.5 11628.7 11703.2 11750.2 11925.7 11430.3 11434.0 11552.4 11773.4 11848.5 10325.2 10339.6 10445.8 10446.6 10449.4 7838.1 7991.3 8022.6 8027.9 8060.2 8350.0 8372.4 8479.6 8498.1 8518.3 17:30:15 INFO - PID 3560 | 17:30:15 INFO - PID 3560 | [#4] prototype.html Cycles:180 Average:5538.29 Median:6175.13 stddev:1570.31 (25.4%) stddev-sans-first:1529.03 17:30:15 INFO - PID 3560 | Values: 528.6 530.9 538.1 542.7 544.9 6060.7 6127.8 6179.4 6191.8 6237.8 6063.2 6092.9 6102.2 6114.1 6117.8 4831.7 4925.7 4934.3 4948.8 4949.8 4672.7 4789.0 4824.3 4857.4 4898.8 4720.5 4761.0 4764.8 4778.4 4788.7 4770.8 4773.9 4801.2 4806.2 4830.4 4341.8 4371.3 4380.8 4390.7 4405.0 5949.9 6003.1 6018.9 6041.1 6062.2 5630.3 5653.3 5674.1 5717.8 5757.4 6447.3 6450.9 6458.7 6504.1 6516.4 4919.3 4919.5 4927.2 4932.2 4940.9 6483.4 6597.8 6707.2 6734.8 6834.9 4957.5 5008.4 5027.6 5054.2 5077.9 5100.6 5115.2 5140.7 5147.4 5158.6 5682.7 5694.2 5707.3 5723.4 5754.1 6460.9 6509.8 6530.2 6583.0 6605.5 1758.2 1793.4 1796.5 1800.7 1803.3 1195.0 1232.9 1243.6 1263.7 1278.6 6244.5 6281.4 6284.7 6284.9 6298.2 6547.7 6586.5 6601.3 6601.4 6614.2 5987.7 6109.7 6124.4 6170.9 6184.0 3492.4 3497.6 3498.1 3515.4 3533.4 6892.7 6916.6 6944.8 7016.0 7035.8 6429.6 6766.2 6839.0 6851.4 6902.5 6941.8 6952.0 6962.4 6980.1 6997.2 6637.2 6646.9 6665.9 6667.6 6689.6 6607.4 6609.4 6622.5 6650.9 6658.7 7015.6 7033.5 7042.9 7067.2 7097.4 5096.5 5104.4 5104.5 5119.2 5133.0 6464.0 6602.8 6630.4 6725.6 6802.3 6447.4 6496.3 6510.8 6527.3 6540.5 6458.9 6468.6 6495.5 6496.7 6541.0 6430.4 6496.3 6514.2 6519.6 6551.4 6472.6 6554.8 6556.9 6572.7 6574.9 6356.7 6375.3 6376.0 6389.7 6407.2 17:30:15 INFO - PID 3560 | 17:30:15 INFO - PID 3560 | [#5] yui.html Cycles:180 Average:27602.59 Median:20355.14 stddev:38947.95 (191.3%) stddev-sans-first:39005.78 17:30:15 INFO - PID 3560 | Values: 946.4 951.1 963.3 965.2 972.7 19643.2 20337.2 20354.5 20355.8 20371.8 16687.4 16870.9 22476.6 22501.2 22543.8 1055.5 1096.0 1096.1 1096.8 1098.0 1043.7 1081.7 1106.0 1109.6 1110.2 1145.2 1151.0 1151.3 1151.8 1153.6 1143.8 1144.3 1144.5 1144.8 1145.0 840.6 841.3 841.3 841.4 844.0 18369.3 18643.1 18719.0 18839.5 19372.2 22232.3 22539.4 22708.3 22724.0 22801.8 15862.4 15962.4 16027.3 16093.9 16098.2 3766.7 3775.2 3785.8 3792.3 3793.3 141812.0 142653.3 143657.0 143662.0 144000.3 16993.2 17523.4 17553.7 17560.6 17692.4 32701.5 33985.0 34007.5 34161.5 34205.8 9065.1 9142.7 9231.3 9246.0 9255.3 4347.3 4408.5 4415.4 4433.9 4435.4 5451.4 5455.3 5486.9 5505.5 5531.6 1119.7 1125.3 1134.2 1135.6 1138.6 725.3 744.8 748.3 760.8 765.7 12578.7 13389.9 13501.5 14517.2 14774.6 723.1 726.5 727.2 736.7 736.9 5674.9 5715.7 5788.9 6659.8 7173.5 136688.0 136959.3 138389.0 139485.0 142252.3 115997.0 116981.4 119008.4 120045.0 122445.4 99747.5 102399.0 105892.0 108721.5 110396.4 13793.7 13813.4 14083.6 14646.1 14734.3 49344.5 49702.0 49890.0 50019.5 50607.0 82249.4 85915.0 87634.6 88146.0 90607.0 20273.7 21233.2 21245.7 21260.0 21264.3 21635.8 21819.1 22566.9 23410.6 23513.2 20172.8 20686.6 21000.4 21018.5 21491.2 18458.4 18584.1 18669.2 18861.3 19329.6 20381.2 20768.7 20932.4 21160.2 21221.0 14393.4 14440.9 14508.3 14521.4 14532.9 16416.9 16908.2 17070.8 17071.3 17222.9 17:30:15 INFO - PID 3560 | -------- Summary: end -------- 17:30:15 INFO - PID 3560 | 17:30:15 INFO - TEST-INFO | 3560: exit 0 17:30:15 INFO - TEST-OK | dromaeo_css | took 1112426ms 17:30:15 INFO - TEST-START | kraken 17:30:15 INFO - Initialising browser for kraken test... 17:30:15 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:34476/getInfo.html -profile /tmp/tmpudOpQv/profile 17:30:15 INFO - TEST-INFO | started process 3973 (/builds/slave/test/build/application/firefox/firefox http://localhost:34476/getInfo.html) 17:30:21 INFO - TEST-INFO | 3973: exit 0 17:30:21 INFO - Browser initialized. 17:30:21 INFO - Running cycle 1/1 for kraken test... 17:30:21 INFO - TEST-INFO | started process 4148 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpudOpQv/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 17:30:22 INFO - PID 4148 | 17:30:22 INFO - PID 4148 | (/builds/slave/test/build/application/firefox/firefox:4198): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 17:30:22 INFO - PID 4148 | 17:30:22 INFO - PID 4148 | 17:30:22 INFO - PID 4148 | (/builds/slave/test/build/application/firefox/firefox:4251): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 17:30:22 INFO - PID 4148 | 17:30:22 INFO - PID 4148 | __metrics Screen width/height:1600/1200 17:30:22 INFO - PID 4148 | colorDepth:24 17:30:22 INFO - PID 4148 | Browser inner width/height: 1024/768 17:30:22 INFO - PID 4148 | __metrics 17:30:32 INFO - PID 4148 | RSS: Main: 166002688 17:30:32 INFO - PID 4148 | 17:30:35 INFO - PID 4148 | Cycle 1(1): loaded http://localhost:34476/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:34476/tests/kraken/driver.html?testName=audio-beat-detection) 17:30:36 INFO - PID 4148 | RSS: Main: 170582016 17:30:36 INFO - PID 4148 | 17:30:38 INFO - PID 4148 | Cycle 1(1): loaded http://localhost:34476/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:34476/tests/kraken/driver.html?testName=audio-dft) 17:30:39 INFO - PID 4148 | RSS: Main: 172441600 17:30:39 INFO - PID 4148 | 17:30:42 INFO - PID 4148 | Cycle 1(1): loaded http://localhost:34476/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:34476/tests/kraken/driver.html?testName=audio-fft) 17:30:42 INFO - PID 4148 | RSS: Main: 165789696 17:30:42 INFO - PID 4148 | 17:30:44 INFO - PID 4148 | Cycle 1(1): loaded http://localhost:34476/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:34476/tests/kraken/driver.html?testName=audio-oscillator) 17:30:45 INFO - PID 4148 | RSS: Main: 167092224 17:30:45 INFO - PID 4148 | 17:30:47 INFO - PID 4148 | Cycle 1(1): loaded http://localhost:34476/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:34476/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:30:48 INFO - PID 4148 | RSS: Main: 166989824 17:30:48 INFO - PID 4148 | 17:30:51 INFO - PID 4148 | Cycle 1(1): loaded http://localhost:34476/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:34476/tests/kraken/driver.html?testName=imaging-darkroom) 17:30:51 INFO - PID 4148 | RSS: Main: 166707200 17:30:51 INFO - PID 4148 | 17:30:55 INFO - PID 4148 | Cycle 1(1): loaded http://localhost:34476/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:34476/tests/kraken/driver.html?testName=imaging-desaturate) 17:30:55 INFO - PID 4148 | RSS: Main: 169996288 17:30:55 INFO - PID 4148 | 17:30:58 INFO - PID 4148 | Cycle 1(1): loaded http://localhost:34476/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:34476/tests/kraken/driver.html?testName=json-parse-financial) 17:30:59 INFO - PID 4148 | RSS: Main: 168984576 17:30:59 INFO - PID 4148 | 17:31:00 INFO - PID 4148 | Cycle 1(1): loaded http://localhost:34476/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:34476/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:31:01 INFO - PID 4148 | RSS: Main: 168931328 17:31:01 INFO - PID 4148 | 17:31:03 INFO - PID 4148 | Cycle 1(1): loaded http://localhost:34476/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:34476/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:31:03 INFO - PID 4148 | RSS: Main: 169017344 17:31:03 INFO - PID 4148 | 17:31:05 INFO - PID 4148 | Cycle 1(1): loaded http://localhost:34476/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:34476/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:31:06 INFO - PID 4148 | RSS: Main: 168624128 17:31:06 INFO - PID 4148 | 17:31:08 INFO - PID 4148 | Cycle 1(1): loaded http://localhost:34476/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:34476/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:31:09 INFO - PID 4148 | RSS: Main: 168964096 17:31:09 INFO - PID 4148 | 17:31:12 INFO - PID 4148 | Cycle 1(1): loaded http://localhost:34476/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:34476/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:31:13 INFO - PID 4148 | RSS: Main: 169152512 17:31:13 INFO - PID 4148 | 17:31:14 INFO - PID 4148 | Cycle 1(1): loaded http://localhost:34476/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:34476/tests/kraken/driver.html?testName=ai-astar) 17:31:14 INFO - PID 4148 | RSS: Main: 170971136 17:31:14 INFO - PID 4148 | 17:31:14 INFO - PID 4148 | __start_tp_report 17:31:14 INFO - PID 4148 | _x_x_mozilla_page_load 17:31:14 INFO - PID 4148 | _x_x_mozilla_page_load_details 17:31:14 INFO - PID 4148 | |i|pagename|runs| 17:31:14 INFO - PID 4148 | |0;ai-astar;98;115;101;106;108;109;109;97;108;109 17:31:14 INFO - PID 4148 | |1;audio-beat-detection;141;116;152;185;113;151;142;116;185;118 17:31:14 INFO - PID 4148 | |2;audio-dft;163;162;163;163;164;162;162;163;165;162 17:31:14 INFO - PID 4148 | |3;audio-fft;75;75;73;168;74;74;73;75;163;74 17:31:14 INFO - PID 4148 | |4;audio-oscillator;78;77;126;80;79;78;129;79;79;130 17:31:14 INFO - PID 4148 | |5;imaging-gaussian-blur;115;114;114;114;114;113;113;114;113;113 17:31:14 INFO - PID 4148 | |6;imaging-darkroom;148;148;148;148;148;148;149;148;151;148 17:31:14 INFO - PID 4148 | |7;imaging-desaturate;95;94;95;95;94;94;94;93;94;94 17:31:14 INFO - PID 4148 | |8;json-parse-financial;48;55;47;47;48;47;49;55;47;47 17:31:14 INFO - PID 4148 | |9;json-stringify-tinderbox;54;55;54;54;53;54;54;54;53;53 17:31:14 INFO - PID 4148 | |10;stanford-crypto-aes;74;73;73;74;73;73;73;72;72;72 17:31:14 INFO - PID 4148 | |11;stanford-crypto-ccm;121;117;116;114;112;113;120;119;112;159 17:31:14 INFO - PID 4148 | |12;stanford-crypto-pbkdf2;162;174;165;162;167;170;164;165;164;166 17:31:14 INFO - PID 4148 | |13;stanford-crypto-sha256-iterative;70;63;60;60;63;61;60;60;61;70 17:31:14 INFO - PID 4148 | __end_tp_report 17:31:14 INFO - PID 4148 | __start_cc_report 17:31:14 INFO - PID 4148 | _x_x_mozilla_cycle_collect,881 17:31:14 INFO - PID 4148 | __end_cc_report 17:31:14 INFO - PID 4148 | __startTimestamp1503102674977__endTimestamp 17:31:14 INFO - PID 4148 | 17:31:14 INFO - PID 4148 | ------- Summary: start ------- 17:31:14 INFO - PID 4148 | Number of tests: 14 17:31:14 INFO - PID 4148 | 17:31:14 INFO - PID 4148 | [#0] ai-astar Cycles:10 Average:106.00 Median:109.00 stddev:5.64 (5.2%) stddev-sans-first:5.18 17:31:14 INFO - PID 4148 | Values: 98.0 115.0 101.0 106.0 108.0 109.0 109.0 97.0 108.0 109.0 17:31:14 INFO - PID 4148 | 17:31:14 INFO - PID 4148 | [#1] audio-beat-detection Cycles:10 Average:141.90 Median:146.50 stddev:27.18 (18.6%) stddev-sans-first:28.83 17:31:14 INFO - PID 4148 | Values: 141.0 116.0 152.0 185.0 113.0 151.0 142.0 116.0 185.0 118.0 17:31:14 INFO - PID 4148 | 17:31:14 INFO - PID 4148 | [#2] audio-dft Cycles:10 Average:162.90 Median:163.00 stddev:0.99 (0.6%) stddev-sans-first:1.05 17:31:14 INFO - PID 4148 | Values: 163.0 162.0 163.0 163.0 164.0 162.0 162.0 163.0 165.0 162.0 17:31:14 INFO - PID 4148 | 17:31:14 INFO - PID 4148 | [#3] audio-fft Cycles:10 Average:92.40 Median:74.00 stddev:38.55 (52.1%) stddev-sans-first:40.37 17:31:14 INFO - PID 4148 | Values: 75.0 75.0 73.0 168.0 74.0 74.0 73.0 75.0 163.0 74.0 17:31:14 INFO - PID 4148 | 17:31:14 INFO - PID 4148 | [#4] audio-oscillator Cycles:10 Average:93.50 Median:78.50 stddev:24.07 (30.7%) stddev-sans-first:24.87 17:31:14 INFO - PID 4148 | Values: 78.0 77.0 126.0 80.0 79.0 78.0 129.0 79.0 79.0 130.0 17:31:14 INFO - PID 4148 | 17:31:14 INFO - PID 4148 | [#5] imaging-gaussian-blur Cycles:10 Average:113.70 Median:114.00 stddev:0.67 (0.6%) stddev-sans-first:0.53 17:31:14 INFO - PID 4148 | Values: 115.0 114.0 114.0 114.0 114.0 113.0 113.0 114.0 113.0 113.0 17:31:14 INFO - PID 4148 | 17:31:14 INFO - PID 4148 | [#6] imaging-darkroom Cycles:10 Average:148.40 Median:148.00 stddev:0.97 (0.7%) stddev-sans-first:1.01 17:31:14 INFO - PID 4148 | Values: 148.0 148.0 148.0 148.0 148.0 148.0 149.0 148.0 151.0 148.0 17:31:14 INFO - PID 4148 | 17:31:14 INFO - PID 4148 | [#7] imaging-desaturate Cycles:10 Average:94.20 Median:94.00 stddev:0.63 (0.7%) stddev-sans-first:0.60 17:31:14 INFO - PID 4148 | Values: 95.0 94.0 95.0 95.0 94.0 94.0 94.0 93.0 94.0 94.0 17:31:14 INFO - PID 4148 | 17:31:14 INFO - PID 4148 | [#8] json-parse-financial Cycles:10 Average:49.00 Median:48.00 stddev:3.23 (6.7%) stddev-sans-first:3.41 17:31:14 INFO - PID 4148 | Values: 48.0 55.0 47.0 47.0 48.0 47.0 49.0 55.0 47.0 47.0 17:31:14 INFO - PID 4148 | 17:31:14 INFO - PID 4148 | [#9] json-stringify-tinderbox Cycles:10 Average:53.80 Median:54.00 stddev:0.63 (1.2%) stddev-sans-first:0.67 17:31:14 INFO - PID 4148 | Values: 54.0 55.0 54.0 54.0 53.0 54.0 54.0 54.0 53.0 53.0 17:31:14 INFO - PID 4148 | 17:31:14 INFO - PID 4148 | [#10] stanford-crypto-aes Cycles:10 Average:72.90 Median:73.00 stddev:0.74 (1.0%) stddev-sans-first:0.67 17:31:14 INFO - PID 4148 | Values: 74.0 73.0 73.0 74.0 73.0 73.0 73.0 72.0 72.0 72.0 17:31:14 INFO - PID 4148 | 17:31:14 INFO - PID 4148 | [#11] stanford-crypto-ccm Cycles:10 Average:120.30 Median:118.00 stddev:13.98 (11.9%) stddev-sans-first:14.83 17:31:14 INFO - PID 4148 | Values: 121.0 117.0 116.0 114.0 112.0 113.0 120.0 119.0 112.0 159.0 17:31:14 INFO - PID 4148 | 17:31:14 INFO - PID 4148 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:165.90 Median:165.50 stddev:3.70 (2.2%) stddev-sans-first:3.64 17:31:14 INFO - PID 4148 | Values: 162.0 174.0 165.0 162.0 167.0 170.0 164.0 165.0 164.0 166.0 17:31:14 INFO - PID 4148 | 17:31:14 INFO - PID 4148 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.80 Median:62.00 stddev:3.97 (6.4%) stddev-sans-first:3.24 17:31:14 INFO - PID 4148 | Values: 70.0 63.0 60.0 60.0 63.0 61.0 60.0 60.0 61.0 70.0 17:31:14 INFO - PID 4148 | -------- Summary: end -------- 17:31:14 INFO - PID 4148 | 17:31:15 INFO - PID 4148 | 17:31:15 INFO - PID 4148 | ###!!! [Parent][MessageChannel] Error: (msgtype=0x150079,name=PBrowser::Msg_Destroy) Closed channel: cannot send/recv 17:31:15 INFO - PID 4148 | 17:31:15 INFO - PID 4148 | 17:31:15 INFO - PID 4148 | ###!!! [Child][MessageChannel] Error: (msgtype=0x150001,name=PBrowser::Msg_AsyncMessage) Closed channel: cannot send/recv 17:31:15 INFO - PID 4148 | 17:31:15 INFO - PID 4148 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 17:31:15 INFO - TEST-INFO | 4148: exit 0 17:31:15 INFO - TEST-OK | kraken | took 59813ms 17:31:15 INFO - SUITE-END | took 1172s 17:31:16 INFO - Completed test suite (00:19:32) 17:31:16 INFO - javascript benchmark 17:31:16 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8906.58042847616, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3482.912927176822, 3503.824808759561, 3541.9114522136933, 3544.308859772344, 3554.253606742584, 6156.753729850806, 6294.905576416346, 6302.590331628441, 6307.148534947781, 6358.109864618957, 6176.567640265183, 6285.434310912017, 6291.245050593924, 6302.212223472066, 6306.274778400485, 5477.4796394342475, 5503.3120859892515, 5554.361248456418, 5600.887982240352, 5606.6636001839815, 5538.6122971392015, 5610.747516361774, 5617.41017193195, 5634.746436410372, 5667.348254950672, 5428.647137936041, 5476.91784623231, 5541.861453463655, 5571.8885622287735, 5639.859003524924, 5547.44525547442, 5556.444355564452, 5587.664740115606, 5625.099984002581, 5633.380328163898, 5532.170174473821, 5535.474129957688, 5561.805336813232, 5592.105263157916, 5611.438856114397, 6082.9695851520455, 6212.65830379329, 6236.87526249477, 6239.844003899939, 6288.371162883721, 6751.864962700768, 6765.154355705537, 6780.220274668378, 6792.218894827109, 6801.4558835293055, 6819.283975182584, 6846.657667116624, 6862.622555759432, 6873.072135261776, 6873.656317184121, 6244.6253224806205, 6318.557700960934, 6323.20959880015, 6327.0, 6343.777967771106, 7012.368886800213, 7057.258987806206, 7076.256993015762, 7086.716531338792, 7092.290770922969, 6693.732250709917, 6697.330266973361, 6740.662966851638, 6777.322267773282, 6792.150981127359, 6687.063811066455, 6731.326867313327, 6783.321667833177, 6801.319868013159, 6917.0, 6760.864782704417, 6762.357576030269, 6765.8646827063185, 6786.524943254023, 6793.694283757144, 6809.148856392951, 6851.931480685229, 6884.690188941509, 6886.51794374399, 6915.308469153045, 4831.178699621073, 4893.559579637849, 4924.236743304794, 4928.950710492849, 4938.975305123451, 4322.805473753689, 4325.480942286946, 4346.587074227943, 4361.9127617447475, 4462.553744625511, 6509.316521765241, 6519.152510173742, 6549.050387693757, 6569.047488114196, 6570.934290657128, 6768.627725475048, 6871.9656401717675, 6920.204176519765, 6931.34152255545, 6934.861302773917, 6311.33730958252, 6417.358264173638, 6436.292007879129, 6515.8696826063215, 6544.607323560602, 5437.374701909252, 5501.477359650827, 5514.641548299348, 5532.917006244909, 5533.778648854081, 7131.607761573163, 7132.322429369202, 7209.71161153548, 7218.530795498275, 7231.349178573849, 6813.488988325995, 6814.625195614289, 6847.144106986527, 6884.139482564679, 6906.343897329745, 6937.583744975116, 7007.6145811978795, 7009.264027277062, 7022.0, 7023.613701246481, 6688.297728738413, 6704.0, 6775.86448271022, 6776.356246156607, 6823.454123670193, 6871.931280687129, 6887.173539175131, 6919.238883722685, 6938.236793952762, 6948.930510694829, 6567.408933196035, 6574.309697481695, 6623.304553021863, 6655.833604159935, 6688.531802773759, 6449.5485316027425, 6568.343165683585, 6572.572782769296, 6574.572652777745, 6580.5064620152725, 6486.254080780771, 6568.310327415744, 6624.304448032887, 6642.202935647753, 6700.430463410665, 6666.166729158856, 6715.4963377747845, 6730.427913627396, 6737.461003119836, 6753.0883330751685, 6466.0947467355545, 6528.67356632176, 6529.542931994714, 6551.541392102507, 6559.376859198369], "value": 6200.235217936572, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [863.3731294385186, 898.0346127912492, 932.5337331334333, 935.5322338830584, 945.0455040409189, 40805.183896322094, 41636.583634163646, 41710.0, 41730.791346043305, 41748.58251417489, 39297.41053884194, 39445.40831887524, 39470.21059578807, 39556.80221598895, 39887.60112398875, 6863.828404289883, 6981.720731170747, 6982.615956122411, 6987.615681137536, 6987.650617469106, 6930.5841649500935, 6987.475939304547, 6988.825279368031, 6997.825054373656, 7004.824879378006, 7484.476086673935, 7567.394608431312, 7592.240775922419, 7603.771886843404, 7605.6577454014705, 7507.4369422293275, 7528.849423011564, 7531.171571127172, 7549.962250188769, 7564.281393267658, 7396.0, 7397.963010184914, 7524.435667324972, 7530.209328020588, 7536.5101268417375, 39067.0, 39516.407253891215, 39523.20953580941, 39532.407013894815, 39592.0, 3439.724822014233, 3467.7745946513396, 3468.0289518934737, 3474.513568100468, 3485.268093700326, 30479.085627431214, 30674.0, 30675.69324306773, 30740.53889191664, 30741.692583074106, 5025.924611130836, 5048.924266136011, 5062.417821950486, 5072.72100034498, 5092.032513822362, 206788.9999999985, 206979.0, 207599.0, 208460.0, 208748.0, 50307.0, 50501.0, 50564.74717626462, 50658.24012639813, 50666.493335066916, 52438.213426798626, 52577.0, 52616.736916315174, 52650.21024684633, 52681.0, 16601.41895033668, 17076.060816654954, 17132.571685707706, 17135.0, 17137.485875423758, 13862.792058119136, 13876.653083672989, 13907.09603875765, 13973.231472269123, 13974.0, 14909.403623854925, 14912.925435372754, 14955.327010284345, 15027.924860375628, 15286.464973725866, 5798.681072540966, 5905.527557795452, 5948.0, 6029.0, 6035.517158627299, 1040.0327695243345, 1075.800976819291, 1076.4994277660926, 1076.8115579773507, 1086.4784903246486, 24597.38506537315, 24698.753012469646, 24894.626580601307, 24899.377515562257, 24956.875215623804, 1172.9296242225494, 1173.636172786439, 1176.300101439642, 1180.321315243721, 1182.562451892788, 12840.101192916407, 13021.609351719464, 13100.475980960655, 13106.475740970445, 13244.933775331061, 274432.0, 274913.0, 275075.0, 275906.0, 276091.0, 54286.72856635691, 54813.451865481635, 58058.0, 58241.0, 58596.41403585995, 1485.5172069077594, 1500.1473180621924, 1503.4211828446128, 1525.0, 1525.6109692028463, 28913.855430722713, 29180.7081929178, 29232.269193269487, 29527.0, 30006.699933001262, 38756.6124338753, 38806.2238755229, 38811.805940971244, 38850.0, 38875.80562097171, 218971.0, 219144.0, 219298.0, 219616.0, 219935.0, 33226.833865830515, 34244.0, 34351.65648343485, 34357.312853743286, 34359.31281374308, 42291.36562951496, 42907.570924290354, 43458.78270608627, 43478.0, 43670.56329436665, 32477.18807029843, 32901.50647740238, 32988.0, 33075.83462082674, 33385.0, 33050.504242436866, 33252.33495330128, 33341.83329083339, 33682.0, 33709.0, 37725.811370944066, 37894.8105259483, 37984.81007595055, 38074.23851523009, 38123.046923827125, 31896.840515797274, 31933.0, 31942.36115277635, 31971.520427193147, 32154.83922580372, 23580.855779406105, 23825.642615361132, 24598.407598827136, 24732.0, 25032.0], "value": 17727.63237086691, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [567.1351189436109, 576.6857062900717, 577.3504807092022, 578.7164289498147, 593.8426317025989, 22327.888360558194, 22636.094556217773, 23030.539389212227, 23091.307260782163, 23156.189533366334, 26039.609405858926, 26425.20724378267, 26515.86742066292, 26674.73325266747, 26715.332116697093, 6218.22272215973, 6348.047792831089, 6360.300366959631, 6364.649944253064, 6369.426751592356, 5809.244798176232, 6041.486473649745, 6069.089636554508, 6100.633961962297, 6105.877882442349, 6080.391960803929, 6084.0, 6084.939150608481, 6086.087086936951, 6086.452219300262, 6067.302260240085, 6074.726637301332, 6078.088286756978, 6080.118382834465, 6082.057281121433, 5645.661260324394, 5646.943530564683, 5677.602567820254, 5683.914741278884, 5688.345840228385, 29788.40423191524, 29954.25114372158, 30098.398032039455, 30597.541036884464, 30641.540376894365, 2137.9893100534396, 2201.4276288165033, 2204.713387259662, 2205.117952818869, 2205.4596623827106, 19823.80176198234, 20338.28815991448, 20351.69472457914, 20383.796162038485, 20385.796142038536, 2213.690083388327, 2442.926712198637, 2484.35406794233, 2530.051230788454, 2530.367408147963, 155929.0, 159515.0, 159577.20211398986, 160117.0, 160166.99999999884, 14957.476488322856, 15598.376064957274, 15655.060696358254, 15763.68472630541, 16065.759013614805, 23285.650715239284, 23416.53166936652, 23544.17595384153, 23586.64620030701, 24033.27900162998, 10785.892141078646, 10909.072728818139, 10999.450027498593, 11009.779804403866, 11197.552097916156, 10143.137833284105, 10181.592736290466, 10285.22860785444, 10296.485175741333, 10355.585776569003, 9798.167155791694, 9891.664625275496, 9906.900930990741, 9960.203183745283, 10132.0, 2712.5795501697266, 2767.3081729567607, 2773.9181719129556, 2800.3559181387986, 2834.929126771847, 1038.1850247555783, 1039.0544604409952, 1062.3667058659403, 1065.0255016659669, 1077.8868218837067, 21154.15383384678, 21683.56632867334, 21710.674339884914, 21988.34034978921, 22101.889490552767, 1131.9943400282946, 1134.387430787382, 1135.392564977733, 1140.2303445174473, 1144.8855114488485, 11601.0, 12025.819612705816, 12038.87961120395, 12155.149139560146, 12230.327331996825, 541205.0, 584232.0, 586208.0, 605833.0, 606877.0, 126114.36942815228, 127710.0, 129838.35080824724, 131502.34248828696, 131866.0, 1226.3316492511603, 1254.8243245945575, 1275.1201670847086, 1280.2830414967834, 1280.9167404118703, 18860.528486787392, 18896.149673265012, 19215.231390744215, 19293.228270869007, 19585.0, 61585.0, 61871.0, 61905.0, 63590.68204658947, 64878.0, 76214.61892690501, 76338.23661763311, 76348.61825690836, 77214.0, 77324.61337693276, 14445.205513696848, 14897.404103835725, 14996.100233985995, 15263.0, 15501.457448989231, 24866.75133248717, 24915.0, 25292.241232763048, 25897.352566185997, 25988.740112598633, 20256.0, 20532.486687832923, 20946.47633809167, 21044.894775526638, 21078.0, 18144.0, 18420.0, 18450.446486605422, 18887.622247554697, 18953.52616184551, 19664.311749088713, 20201.393958181277, 20230.59538809245, 21506.462338441037, 21782.346529604136, 14996.2501874908, 15067.849321506645, 15120.319585618894, 15255.542333730005, 15352.462663806713, 19781.505462363555, 19989.700154497987, 20038.398848034583, 20121.094550744958, 20184.091715872528], "value": 12614.306296105933, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1486.450013495007, 1505.9759363632731, 1539.1611571693427, 1549.6978089272588, 1552.6061246671927, 15350.385984560618, 15941.123238221893, 15982.360705571764, 15983.520494385188, 16027.118508482028, 15757.84242157578, 16217.91891040546, 16913.7462938056, 16917.7462338065, 16925.407610733626, 2720.782337413002, 2753.105240796739, 2755.0632784853146, 2757.379589592346, 2757.420941602266, 2531.2153232497894, 2596.156249219002, 2627.106783693544, 2664.653595032643, 2723.101376545745, 2593.792496600277, 2606.7262937391583, 2626.3171575390443, 2626.921192364232, 2628.027629776985, 2552.5660637691453, 2552.8468291902454, 2557.8337408068414, 2561.820672552922, 2604.322876052221, 2599.727028662001, 2625.474905019004, 2629.855357955312, 2677.0897894715695, 2678.3571942733797, 15972.920135399365, 16076.196190190443, 16078.0, 16079.517614471584, 16086.195690215442, 7898.80252993674, 8136.552489613069, 8147.837043259102, 8151.796205094861, 8157.877631835528, 5047.268146118829, 5181.171012637998, 5257.947420525784, 5302.708351040691, 5377.085895397791, 1806.4219449776076, 1844.1424737497127, 1855.0817345414107, 1896.9146388412555, 1899.7625296837896, 27827.443451131065, 27997.300067498476, 28053.158405247672, 28054.579181312296, 28078.43843123126, 6778.0, 6798.388145066968, 6831.795046148623, 6979.406750426169, 6997.93002069983, 18756.812431875507, 18770.436886893414, 18788.71816922747, 18796.0, 18818.341358052676, 7745.651445684957, 8034.1564135766075, 8036.276735093869, 8037.35701143907, 8037.799055023671, 7353.889691654629, 7383.0, 7464.962675186589, 7476.5514069156025, 7480.438967077491, 4867.367242258554, 4997.0505603935135, 5062.493750624908, 5063.392392912874, 5098.923516147261, 1426.86444787745, 1477.3868844429655, 1699.6175860431551, 1769.4691592522192, 1771.4242871066954, 976.2921881635757, 995.7012896131276, 996.3772642098688, 1000.3597697473623, 1019.0013786489134, 9212.63149474027, 9229.077092290852, 9305.813883722287, 9423.10480504351, 9427.19868811145, 1060.4220699718517, 1084.1651928015542, 1091.4160923905672, 1093.0708897437114, 1103.6027030269097, 5618.297712785902, 5627.803026894039, 5633.26767520228, 5814.360420353758, 5869.8239052828485, 22582.661260081113, 23553.293401197992, 23587.41031474227, 23617.0, 23625.173118940755, 22209.333719988426, 22980.4254893629, 23123.306300811004, 23432.297031089096, 23594.7640523596, 12405.565805196775, 12432.197331386898, 12602.55891043809, 12664.74670506603, 12783.936080319725, 8875.112488751074, 8924.910750892668, 8953.28373730087, 8957.641694332153, 9013.864792027995, 20033.09851056735, 20126.39620811378, 20213.0, 20243.696344554548, 20346.89826550858, 20134.59730805405, 20166.193352265745, 20213.59572808565, 20225.79774202239, 20426.591468170256, 12870.742585148431, 13159.407826648016, 13171.736565268833, 13230.536931207362, 13261.138026028277, 14286.785698214328, 14408.351624176728, 14525.636859078608, 14750.0, 14775.039622424509, 11543.538258469567, 11628.709282268012, 11703.23928944616, 11750.23623464472, 11925.701857453632, 11430.25703329281, 11434.0, 11552.422378880854, 11773.411329433666, 11848.526058957545, 10325.173986080945, 10339.638112666322, 10445.791084178425, 10446.634367797395, 10449.373037617766, 7838.137804841349, 7991.320737737125, 8022.638981245975, 8027.8795818063945, 8060.234277743605, 8350.039745429354, 8372.41393102477, 8479.576021199038, 8498.065212826461, 8518.275946544365], "value": 7022.908099481102, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [528.5612941258755, 530.8885134121836, 538.0825692194808, 542.7286356821589, 544.8774025844185, 6060.666663333521, 6127.846803829906, 6179.351168127349, 6191.845203869905, 6237.781677641277, 6063.211782468284, 6092.939070609293, 6102.237220347457, 6114.113453549244, 6117.755289788403, 4831.734254616003, 4925.679830810986, 4934.28452874333, 4948.7773050212645, 4949.777260023289, 4672.742999135046, 4789.0, 4824.276358546229, 4857.417109946811, 4898.755062246892, 4720.527947205286, 4760.952390476085, 4764.807578922113, 4778.354922085508, 4788.736619485927, 4770.833020844254, 4773.90452190956, 4801.231802911552, 4806.206975848981, 4830.444498882638, 4341.761203133827, 4371.34429835524, 4380.78096095194, 4390.714603550791, 4404.955950440487, 5949.853376829055, 6003.129546215818, 6018.916595012896, 6041.093835924603, 6062.242219722535, 5630.268065151545, 5653.265075540195, 5674.063779476382, 5717.828465146053, 5757.366689664133, 6447.290798012262, 6450.903236451457, 6458.709358078898, 6504.056911747817, 6516.380943810331, 4919.286703428019, 4919.483454237289, 4927.236278376858, 4932.2108462646165, 4940.925886111711, 6483.416492515649, 6597.80206593803, 6707.228668703113, 6734.764283250062, 6834.863302733917, 4957.529034741694, 5008.447381311805, 5027.572656324253, 5054.191329387354, 5077.8730531737, 5100.566451851634, 5115.232715092766, 5140.717260550631, 5147.433782283946, 5158.638895277295, 5682.715864206773, 5694.174344720075, 5707.315122185364, 5723.368839880614, 5754.136879468113, 6460.903086453707, 6509.804705858832, 6530.249021362509, 6582.967085164543, 6605.471562275006, 1758.1912320332535, 1793.372319688125, 1796.4700413378084, 1800.6848801459691, 1803.2696757813108, 1194.952201911931, 1232.896557580978, 1243.570968016033, 1263.6920786985427, 1278.6483716977905, 6244.46922011625, 6281.371862813682, 6284.685765711696, 6284.905726414107, 6298.181236439325, 6547.705353259114, 6586.5389422739945, 6601.306862779339, 6601.3728695773825, 6614.239362473377, 5987.730552125165, 6109.725062372204, 6124.38756124384, 6170.907436388457, 6184.0, 3492.371373152806, 3497.632748561364, 3498.1254686328416, 3515.3848076587005, 3533.434650455915, 6892.655367231619, 6916.55042422241, 6944.791656250321, 7015.964920175468, 7035.753748618774, 6429.6465858432575, 6766.221884483348, 6838.965805170942, 6851.383375496229, 6902.482313826483, 6941.791746247621, 6952.0, 6962.443004559623, 6980.127484064492, 6997.230304666483, 6637.236717777518, 6646.9151099409955, 6665.900011499734, 6667.599944003376, 6689.632070236184, 6607.372299631527, 6609.405153536205, 6622.536422450382, 6650.933490665031, 6658.7336506539195, 7015.579065256101, 7033.542819716907, 7042.859142817218, 7067.222605513492, 7097.396721278749, 5096.490350964874, 5104.4129925057605, 5104.489551044866, 5119.206522988943, 5132.9743351283005, 6464.0, 6602.7689030883685, 6630.436412904764, 6725.562838415487, 6802.251752307143, 6447.3552644735155, 6496.285408604956, 6510.772122975863, 6527.281998980204, 6540.50946179048, 6458.870822583616, 6468.579542329733, 6495.545311828127, 6496.6751662415745, 6541.0, 6430.3891130342545, 6496.252930913006, 6514.1531600891585, 6519.576227545194, 6551.410373066256, 6472.608389196345, 6554.8361290968105, 6556.934430655632, 6572.737090516326, 6574.934250657432, 6356.650384228912, 6375.298717141018, 6375.968120159369, 6389.744410223725, 6407.167068281094], "value": 5082.997914125123, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [946.4415994563207, 951.1012093571576, 963.2577436658579, 965.2229954886313, 972.7227740094074, 19643.214271429144, 20337.18651253948, 20354.491137721565, 20355.796442035575, 20371.796282037176, 16687.415940442086, 16870.915645421785, 22476.550468990612, 22501.21245756399, 22543.774562254373, 1055.4880882771868, 1096.0245381610373, 1096.0628662493573, 1096.7916095941746, 1098.0447011100314, 1043.7286305560533, 1081.686310969818, 1105.9668209953675, 1109.6005438042298, 1110.1562812262657, 1145.1811954452564, 1150.959716409926, 1151.2977083978767, 1151.7869194199059, 1153.5904753812401, 1143.8055530559825, 1144.250515912079, 1144.4678224625588, 1144.7596004838995, 1144.9542018319257, 840.64272684109, 841.2680967558202, 841.3059226138461, 841.3984001439001, 844.0, 18369.265229390807, 18643.067846607617, 18719.0, 18839.529011774815, 19372.225110995543, 22232.333030009126, 22539.43651408728, 22708.31875043735, 22724.0, 22801.77198228013, 15862.36550537977, 15962.361505539764, 16027.278772455267, 16093.919530402272, 16098.195090245441, 3766.6610005099674, 3775.244951009809, 3785.8107094645156, 3792.2794669013074, 3793.2603142387247, 141812.0, 142653.28673356568, 143657.0, 143662.0, 144000.27999859935, 16993.150342482826, 17523.386681466087, 17553.736693949602, 17560.56098597545, 17692.380766673363, 32701.50947735786, 33985.0, 34007.4898876517, 34161.487577686356, 34205.828970854986, 9065.138811813, 9142.680006199751, 9231.261499080058, 9246.029166937375, 9255.259579233645, 4347.282698354736, 4408.470983482002, 4415.381846541422, 4433.933490997638, 4435.423394958635, 5451.400345961941, 5455.263539422127, 5486.91769623456, 5505.504504594525, 5531.585131115102, 1119.652907598647, 1125.2573301620891, 1134.2457265918072, 1135.642272684102, 1138.618562781461, 725.3182008911606, 744.7989042958371, 748.2741740511694, 760.7793739815392, 765.6860687118254, 12578.685532861751, 13389.866101338863, 13501.459941602423, 14517.201553914425, 14774.63063423423, 723.0636325957897, 726.5495392856462, 727.1601300497828, 736.7016358374867, 736.8563130189561, 5674.886502269931, 5715.714214289352, 5788.913166302509, 6659.833504162338, 7173.457706593107, 136688.0, 136959.31520342335, 138389.0, 139485.0, 142252.28873855565, 115997.0, 116981.41509292398, 119008.40495797465, 120045.0, 122445.38777306235, 99747.50126249323, 102399.0, 105892.0, 108721.45639271753, 110396.44801776101, 13793.724125517634, 13813.378397971914, 14083.577492675236, 14646.121232726071, 14734.336954836843, 49344.50655493399, 49702.0, 49890.0, 50019.499805001484, 50607.0, 82249.37118217713, 85915.0, 87634.56182719045, 88146.0, 90607.0, 20273.695894561297, 21233.15067397287, 21245.6813147806, 21260.0, 21264.25575104864, 21635.783642163376, 21819.127234910426, 22566.88716556407, 23410.64884026707, 23513.17703880356, 20172.79827201709, 20686.586268274852, 21000.36998890036, 21018.47453813667, 21491.247806326704, 18458.446246612624, 18584.07079645985, 18669.159887805352, 18861.339853105077, 19329.613407731485, 20381.18475260973, 20768.688469672667, 20932.37202883916, 21160.153593856074, 21221.045052972346, 14393.352299146354, 14440.855591443951, 14508.347124379217, 14521.419143234152, 14532.927335363256, 16416.917915410348, 16908.23912923946, 17070.82929170742, 17071.31714731397, 17222.91388543049], "value": 10085.095854678955, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1477.7000000000003, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 115.0, 101.0, 106.0, 108.0, 109.0, 109.0, 97.0, 108.0, 109.0], "value": 106.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 116.0, 152.0, 185.0, 113.0, 151.0, 142.0, 116.0, 185.0, 118.0], "value": 141.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 162.0, 163.0, 163.0, 164.0, 162.0, 162.0, 163.0, 165.0, 162.0], "value": 162.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 73.0, 168.0, 74.0, 74.0, 73.0, 75.0, 163.0, 74.0], "value": 92.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 77.0, 126.0, 80.0, 79.0, 78.0, 129.0, 79.0, 79.0, 130.0], "value": 93.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 114.0, 114.0, 114.0, 114.0, 113.0, 113.0, 114.0, 113.0, 113.0], "value": 113.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 148.0, 148.0, 148.0, 148.0, 148.0, 149.0, 148.0, 151.0, 148.0], "value": 148.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 95.0, 95.0, 94.0, 94.0, 94.0, 93.0, 94.0, 94.0], "value": 94.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [48.0, 55.0, 47.0, 47.0, 48.0, 47.0, 49.0, 55.0, 47.0, 47.0], "value": 49.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 55.0, 54.0, 54.0, 53.0, 54.0, 54.0, 54.0, 53.0, 53.0], "value": 53.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 73.0, 73.0, 74.0, 73.0, 73.0, 73.0, 72.0, 72.0, 72.0], "value": 72.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [121.0, 117.0, 116.0, 114.0, 112.0, 113.0, 120.0, 119.0, 112.0, 159.0], "value": 120.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 174.0, 165.0, 162.0, 167.0, 170.0, 164.0, 165.0, 164.0, 166.0], "value": 165.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 63.0, 60.0, 60.0, 63.0, 61.0, 60.0, 60.0, 61.0, 70.0], "value": 62.8, "unit": "score"}]}]} 17:31:16 INFO - Return code: 0 17:31:16 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 17:31:16 INFO - # TBPL SUCCESS # 17:31:16 INFO - Running post-action listener: _package_coverage_data 17:31:16 INFO - Running post-action listener: _resource_record_post_action 17:31:16 INFO - [mozharness: 2017-08-19 00:31:16.266043Z] Finished run-tests step (success) 17:31:16 INFO - Running post-run listener: _resource_record_post_run 17:31:16 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 7761920; Write bytes: 430981120; Read time: 2652; Write time: 350656 17:31:16 INFO - TinderboxPrint: CPU usage
13.1% 17:31:16 INFO - TinderboxPrint: I/O read bytes / time
7,761,920 / 2,652 17:31:16 INFO - TinderboxPrint: I/O write bytes / time
430,981,120 / 350,656 17:31:16 INFO - TinderboxPrint: CPU idle
8,253.8 (86.9%) 17:31:16 INFO - TinderboxPrint: CPU user
1,189.3 (12.5%) 17:31:16 INFO - TinderboxPrint: Swap in / out
0 / 0 17:31:16 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 108093440; Read time: 0; Write time: 102400 17:31:16 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 17:31:16 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 5390336; Write bytes: 322887680; Read time: 2360; Write time: 248256 17:31:16 INFO - Running post-run listener: _upload_blobber_files 17:31:16 INFO - Blob upload gear active. 17:31:16 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:31:16 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:31:16 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:31:16 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:31:17 INFO - (blobuploader) - INFO - Open directory for files ... 17:31:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 17:31:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:31:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:31:18 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 17:31:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:31:18 INFO - (blobuploader) - INFO - Done attempting. 17:31:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 17:31:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:31:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:31:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 17:31:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:31:19 INFO - (blobuploader) - INFO - Done attempting. 17:31:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 17:31:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:31:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:31:26 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 17:31:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:31:26 INFO - (blobuploader) - INFO - Done attempting. 17:31:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 17:31:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:31:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:31:27 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 17:31:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:31:27 INFO - (blobuploader) - INFO - Done attempting. 17:31:27 INFO - (blobuploader) - INFO - Iteration through files over. 17:31:27 INFO - Return code: 0 17:31:27 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:31:27 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:31:27 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/00f5bd044bfc71e3c0ecfb1b790b0dfa650d4b444d5b134511d08d39b64cec0d7c1866a7cf49253aee02402c1269a5a4e777f99b2cbadbd246559457fa2e7f78", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fdd733602f9c86f33052fa1d4bf39803db6947935a4b741c29211b02e6a14538b63362a8d12b2657434a5a3987244397333b6de0f918d3e838c78ad68f96d2b1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/93c6248d342246cda64683848883a841bb68483bff4b4f0943ebf3372d73bb6bfbed68bcfaec652a4ddadda1090c918e8239cf0626e40fe0802f1a22ea3dba2a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d97a2800f03eaadb122eae859440e787fab6925293a349ffed60c25eac7ff35c685ebca7550081c0b7244c80a8eb11d8872af7b4464d57178d2118a21781564f"} 17:31:27 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:31:27 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:31:27 INFO - Contents: 17:31:27 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/00f5bd044bfc71e3c0ecfb1b790b0dfa650d4b444d5b134511d08d39b64cec0d7c1866a7cf49253aee02402c1269a5a4e777f99b2cbadbd246559457fa2e7f78", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fdd733602f9c86f33052fa1d4bf39803db6947935a4b741c29211b02e6a14538b63362a8d12b2657434a5a3987244397333b6de0f918d3e838c78ad68f96d2b1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/93c6248d342246cda64683848883a841bb68483bff4b4f0943ebf3372d73bb6bfbed68bcfaec652a4ddadda1090c918e8239cf0626e40fe0802f1a22ea3dba2a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d97a2800f03eaadb122eae859440e787fab6925293a349ffed60c25eac7ff35c685ebca7550081c0b7244c80a8eb11d8872af7b4464d57178d2118a21781564f"} 17:31:27 INFO - Running post-run listener: copy_logs_to_upload_dir 17:31:27 INFO - Copying logs to upload dir... 17:31:27 INFO - mkdir: /builds/slave/test/build/upload/logs 17:31:27 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1254.595838 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2017-08-18 17:31:27.175660) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-18 17:31:27.178766) ========= 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=d2a8c569965ab8367867b893000001a1-1503101429.438516-1988113263 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/00f5bd044bfc71e3c0ecfb1b790b0dfa650d4b444d5b134511d08d39b64cec0d7c1866a7cf49253aee02402c1269a5a4e777f99b2cbadbd246559457fa2e7f78", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fdd733602f9c86f33052fa1d4bf39803db6947935a4b741c29211b02e6a14538b63362a8d12b2657434a5a3987244397333b6de0f918d3e838c78ad68f96d2b1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/93c6248d342246cda64683848883a841bb68483bff4b4f0943ebf3372d73bb6bfbed68bcfaec652a4ddadda1090c918e8239cf0626e40fe0802f1a22ea3dba2a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d97a2800f03eaadb122eae859440e787fab6925293a349ffed60c25eac7ff35c685ebca7550081c0b7244c80a8eb11d8872af7b4464d57178d2118a21781564f"} build_url:https://queue.taskcluster.net/v1/task/XPyRaK6FQe2kUwGj0OMW5Q/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011275 build_url: 'https://queue.taskcluster.net/v1/task/XPyRaK6FQe2kUwGj0OMW5Q/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/00f5bd044bfc71e3c0ecfb1b790b0dfa650d4b444d5b134511d08d39b64cec0d7c1866a7cf49253aee02402c1269a5a4e777f99b2cbadbd246559457fa2e7f78", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fdd733602f9c86f33052fa1d4bf39803db6947935a4b741c29211b02e6a14538b63362a8d12b2657434a5a3987244397333b6de0f918d3e838c78ad68f96d2b1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/93c6248d342246cda64683848883a841bb68483bff4b4f0943ebf3372d73bb6bfbed68bcfaec652a4ddadda1090c918e8239cf0626e40fe0802f1a22ea3dba2a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d97a2800f03eaadb122eae859440e787fab6925293a349ffed60c25eac7ff35c685ebca7550081c0b7244c80a8eb11d8872af7b4464d57178d2118a21781564f"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-18 17:31:27.207169) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-18 17:31:27.207895) ========= 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=d2a8c569965ab8367867b893000001a1-1503101429.438516-1988113263 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004503 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-18 17:31:27.290700) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-18 17:31:27.291163) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-18 17:31:27.291587) ========= ========= Total master_lag: 0.20 =========