builder: mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s slave: talos-linux64-ix-020 starttime: 1503452345.98 results: success (0) revision: 7c50f0c999c5bf8ee915261997597a5a9b8fb2ae ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-08-22 18:39:05.980392) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-08-22 18:39:05.980864) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-22 18:39:05.981148) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-22 18:39:06.001180) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-22 18:39:06.001553) ========= 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=af724c981e2a0f424dbabf99000001e7-1503452345.248225-1268570157 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-08-22 18:39:06-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 42.5M=0s 2017-08-22 18:39:06 (42.5 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.187726 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-22 18:39:06.205329) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-22 18:39:06.205694) ========= 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=af724c981e2a0f424dbabf99000001e7-1503452345.248225-1268570157 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020833 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-22 18:39:06.255840) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-22 18:39:06.259263) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 7c50f0c999c5bf8ee915261997597a5a9b8fb2ae --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 7c50f0c999c5bf8ee915261997597a5a9b8fb2ae --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=af724c981e2a0f424dbabf99000001e7-1503452345.248225-1268570157 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-08-22 18:39:06,629 truncating revision to first 12 chars 2017-08-22 18:39:06,629 Setting DEBUG logging. 2017-08-22 18:39:06,629 attempt 1/10 2017-08-22 18:39:06,629 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/7c50f0c999c5?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-08-22 18:39:07,062 unpacking tar archive at: mozilla-central-7c50f0c999c5/testing/mozharness/ program finished with exit code 0 elapsedTime=0.780372 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-22 18:39:07.054874) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-22 18:39:07.055285) ========= script_repo_revision: 7c50f0c999c5bf8ee915261997597a5a9b8fb2ae ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-22 18:39:07.055744) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-22 18:39:07.056105) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-22 18:39:07.071812) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2017-08-22 18:39:07.072210) ========= /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=af724c981e2a0f424dbabf99000001e7-1503452345.248225-1268570157 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 18:39:07 INFO - MultiFileLogger online at 20170822 18:39:07 in /builds/slave/test 18:39:07 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 18:39:07 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:39:07 INFO - {'append_to_log': False, 18:39:07 INFO - 'base_work_dir': '/builds/slave/test', 18:39:07 INFO - 'blob_upload_branch': 'Firefox', 18:39:07 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:39:07 INFO - 'branch': 'Firefox', 18:39:07 INFO - 'buildbot_json_path': 'buildprops.json', 18:39:07 INFO - 'code_coverage': False, 18:39:07 INFO - 'config_files': ('talos/linux_config.py',), 18:39:07 INFO - 'default_actions': ('clobber', 18:39:07 INFO - 'read-buildbot-config', 18:39:07 INFO - 'download-and-extract', 18:39:07 INFO - 'populate-webroot', 18:39:07 INFO - 'create-virtualenv', 18:39:07 INFO - 'install', 18:39:07 INFO - 'setup-mitmproxy', 18:39:07 INFO - 'run-tests'), 18:39:07 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:39:07 INFO - 'disable_ccov_upload': False, 18:39:07 INFO - 'download_minidump_stackwalk': True, 18:39:07 INFO - 'download_symbols': 'ondemand', 18:39:07 INFO - 'enable_stylo': False, 18:39:07 INFO - 'enable_webrender': False, 18:39:07 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:39:07 INFO - 'tooltool.py': '/tools/tooltool.py', 18:39:07 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:39:07 INFO - '/tools/misc-python/virtualenv.py')}, 18:39:07 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:39:07 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:39:07 INFO - 'gecko_profile': False, 18:39:07 INFO - 'gecko_profile_interval': 0, 18:39:07 INFO - 'installer_path': 'installer.exe', 18:39:07 INFO - 'log_level': 'info', 18:39:07 INFO - 'log_name': 'talos', 18:39:07 INFO - 'log_to_console': True, 18:39:07 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 18:39:07 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 18:39:07 INFO - 'opt_config_files': (), 18:39:07 INFO - 'pip_index': False, 18:39:07 INFO - 'suite': 'dromaeojs-e10s', 18:39:07 INFO - 'system_bits': '32', 18:39:07 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:39:07 INFO - 'title': 'talos-linux64-ix-020', 18:39:07 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:39:07 INFO - 'use_talos_json': True, 18:39:07 INFO - 'verify': 'False', 18:39:07 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:39:07 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:39:07 INFO - 'work_dir': 'build'} 18:39:07 INFO - [mozharness: 2017-08-23 01:39:07.594015Z] Running clobber step. 18:39:07 INFO - Running pre-action listener: _resource_record_pre_action 18:39:07 INFO - Running main action method: clobber 18:39:07 INFO - rmtree: /builds/slave/test/build 18:39:07 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:39:08 INFO - Running post-action listener: _resource_record_post_action 18:39:08 INFO - [mozharness: 2017-08-23 01:39:08.736720Z] Finished clobber step (success) 18:39:08 INFO - [mozharness: 2017-08-23 01:39:08.736817Z] Running read-buildbot-config step. 18:39:08 INFO - Running pre-action listener: _resource_record_pre_action 18:39:08 INFO - Running main action method: read_buildbot_config 18:39:08 INFO - Using buildbot properties: 18:39:08 INFO - { 18:39:08 INFO - "project": "", 18:39:08 INFO - "product": "firefox", 18:39:08 INFO - "who": "ryanvm@gmail.com", 18:39:08 INFO - "installer_path": "public/build/target.tar.bz2", 18:39:08 INFO - "builddir": "mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s", 18:39:08 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 18:39:08 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo-sequential mozilla-central talos dromaeojs-e10s", 18:39:08 INFO - "stage_platform": "linux64-stylosequential", 18:39:08 INFO - "basedir": "/builds/slave/test", 18:39:08 INFO - "buildnumber": 165, 18:39:08 INFO - "platform": "ubuntu64_hw_styloseq", 18:39:08 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 18:39:08 INFO - "slavebuilddir": "test", 18:39:08 INFO - "taskId": "LncsMoMHRw2zxIZqVvi4PQ", 18:39:08 INFO - "branch": "mozilla-central", 18:39:08 INFO - "script_repo_revision": "production", 18:39:08 INFO - "revision": "7c50f0c999c5bf8ee915261997597a5a9b8fb2ae", 18:39:08 INFO - "slavename": "talos-linux64-ix-020", 18:39:08 INFO - "repo_path": "mozilla-central" 18:39:08 INFO - } 18:39:08 INFO - Finding installer, test and symbols from parent task. 18:39:08 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LncsMoMHRw2zxIZqVvi4PQ'}, attempt #1 18:39:09 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LncsMoMHRw2zxIZqVvi4PQ'}, attempt #1 18:39:09 INFO - Task dependencies: B13Ixl9iTias4oEEpdFzUg 18:39:09 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/B13Ixl9iTias4oEEpdFzUg'}, attempt #1 18:39:10 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/B13Ixl9iTias4oEEpdFzUg/artifacts/public/build/target.tar.bz2 18:39:10 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/B13Ixl9iTias4oEEpdFzUg/artifacts/public/build/target.test_packages.json 18:39:10 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/B13Ixl9iTias4oEEpdFzUg/artifacts/public/build/target.crashreporter-symbols.zip 18:39:10 INFO - Running post-action listener: _resource_record_post_action 18:39:10 INFO - [mozharness: 2017-08-23 01:39:10.092370Z] Finished read-buildbot-config step (success) 18:39:10 INFO - [mozharness: 2017-08-23 01:39:10.092588Z] Running download-and-extract step. 18:39:10 INFO - Running pre-action listener: _resource_record_pre_action 18:39:10 INFO - Running main action method: download_and_extract 18:39:10 INFO - mkdir: /builds/slave/test/build/tests 18:39:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:39:10 INFO - trying https://queue.taskcluster.net/v1/task/B13Ixl9iTias4oEEpdFzUg/artifacts/public/build/target.test_packages.json 18:39:10 INFO - Downloading https://queue.taskcluster.net/v1/task/B13Ixl9iTias4oEEpdFzUg/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 18:39:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/B13Ixl9iTias4oEEpdFzUg/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 18:39:10 INFO - Downloaded 989 bytes. 18:39:10 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 18:39:10 INFO - Using the following test package requirements: 18:39:10 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 18:39:10 INFO - u'common': [u'target.common.tests.zip'], 18:39:10 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 18:39:10 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 18:39:10 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 18:39:10 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 18:39:10 INFO - u'mozbase': [u'target.common.tests.zip'], 18:39:10 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 18:39:10 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 18:39:10 INFO - u'web-platform': [u'target.common.tests.zip', 18:39:10 INFO - u'target.web-platform.tests.tar.gz'], 18:39:10 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 18:39:10 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 18:39:10 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/B13Ixl9iTias4oEEpdFzUg/artifacts/public/build/target.common.tests.zip 18:39:10 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/B13Ixl9iTias4oEEpdFzUg/artifacts/public/build/target.common.tests.zip'}, attempt #1 18:39:10 INFO - Fetch https://queue.taskcluster.net/v1/task/B13Ixl9iTias4oEEpdFzUg/artifacts/public/build/target.common.tests.zip into memory 18:39:11 INFO - Content-Length response header: 54949693 18:39:11 INFO - Bytes received: 54949693 18:39:22 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 18:39:22 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/B13Ixl9iTias4oEEpdFzUg/artifacts/public/build/target.common.tests.zip 18:39:22 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/B13Ixl9iTias4oEEpdFzUg/artifacts/public/build/target.common.tests.zip'}, attempt #1 18:39:22 INFO - Fetch https://queue.taskcluster.net/v1/task/B13Ixl9iTias4oEEpdFzUg/artifacts/public/build/target.common.tests.zip into memory 18:39:24 INFO - Content-Length response header: 54949693 18:39:24 INFO - Bytes received: 54949693 18:39:36 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/B13Ixl9iTias4oEEpdFzUg/artifacts/public/build/target.talos.tests.zip 18:39:36 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/B13Ixl9iTias4oEEpdFzUg/artifacts/public/build/target.talos.tests.zip'}, attempt #1 18:39:36 INFO - Fetch https://queue.taskcluster.net/v1/task/B13Ixl9iTias4oEEpdFzUg/artifacts/public/build/target.talos.tests.zip into memory 18:39:37 INFO - Content-Length response header: 14496256 18:39:37 INFO - Bytes received: 14496256 18:39:37 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')]} 18:39:37 INFO - trying https://queue.taskcluster.net/v1/task/B13Ixl9iTias4oEEpdFzUg/artifacts/public/build/target.tar.bz2 18:39:37 INFO - Downloading https://queue.taskcluster.net/v1/task/B13Ixl9iTias4oEEpdFzUg/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 18:39:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/B13Ixl9iTias4oEEpdFzUg/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 18:39:38 INFO - Downloaded 61164089 bytes. 18:39:38 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/B13Ixl9iTias4oEEpdFzUg/artifacts/public/build/target.tar.bz2 18:39:38 INFO - mkdir: /builds/slave/test/properties 18:39:38 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:39:38 INFO - Writing to file /builds/slave/test/properties/build_url 18:39:38 INFO - Contents: 18:39:38 INFO - build_url:https://queue.taskcluster.net/v1/task/B13Ixl9iTias4oEEpdFzUg/artifacts/public/build/target.tar.bz2 18:39:38 INFO - Running post-action listener: _resource_record_post_action 18:39:38 INFO - Running post-action listener: find_tests_for_verification 18:39:38 INFO - Running post-action listener: set_extra_try_arguments 18:39:38 INFO - [mozharness: 2017-08-23 01:39:38.557090Z] Finished download-and-extract step (success) 18:39:38 INFO - [mozharness: 2017-08-23 01:39:38.557187Z] Running populate-webroot step. 18:39:38 INFO - Running pre-action listener: _resource_record_pre_action 18:39:38 INFO - Running main action method: populate_webroot 18:39:38 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 18:39:38 INFO - 'chromez-stylo-e10s': {'talos_options': ['--stylo'], 18:39:38 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:39:38 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 18:39:38 INFO - 'dromaeojs-stylo-e10s': {'talos_options': ['--stylo'], 18:39:38 INFO - 'tests': ['dromaeo_css', 'kraken']}, 18:39:38 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 18:39:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:39:38 INFO - 'g1-stylo-e10s': {'pagesets_name': 'tp5n.zip', 18:39:38 INFO - 'talos_options': ['--stylo'], 18:39:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:39:38 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 18:39:38 INFO - 'tests': ['damp', 'tps']}, 18:39:38 INFO - 'g2-stylo-e10s': {'pagesets_name': 'tp5n.zip', 18:39:38 INFO - 'talos_options': ['--stylo'], 18:39:38 INFO - 'tests': ['damp', 'tps']}, 18:39:38 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:39:38 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 18:39:38 INFO - 'g4-stylo-e10s': {'talos_options': ['--stylo'], 18:39:38 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 18:39:38 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 18:39:38 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 18:39:38 INFO - 'g5-stylo-e10s': {'pagesets_name': 'tp5n.zip', 18:39:38 INFO - 'talos_options': ['--stylo'], 18:39:38 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 18:39:38 INFO - 'other-e10s': {'tests': ['a11yr', 18:39:38 INFO - 'ts_paint', 18:39:38 INFO - 'tpaint', 18:39:38 INFO - 'sessionrestore', 18:39:38 INFO - 'sessionrestore_many_windows', 18:39:38 INFO - 'sessionrestore_no_auto_restore', 18:39:38 INFO - 'tabpaint']}, 18:39:38 INFO - 'other-stylo-e10s': {'talos_options': ['--stylo'], 18:39:38 INFO - 'tests': ['a11yr', 18:39:38 INFO - 'ts_paint', 18:39:38 INFO - 'tpaint', 18:39:38 INFO - 'sessionrestore', 18:39:38 INFO - 'sessionrestore_many_windows', 18:39:38 INFO - 'sessionrestore_no_auto_restore', 18:39:38 INFO - 'tabpaint']}, 18:39:38 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 18:39:38 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 18:39:38 INFO - 'perf-reftest-singletons-stylo-e10s': {'talos_options': ['--stylo'], 18:39:38 INFO - 'tests': ['bloom_basic_singleton']}, 18:39:38 INFO - 'perf-reftest-stylo-e10s': {'talos_options': ['--stylo'], 18:39:38 INFO - 'tests': ['bloom_basic']}, 18:39:38 INFO - 'svgr-e10s': {'tests': ['tsvgx', 18:39:38 INFO - 'tsvgr_opacity', 18:39:38 INFO - 'tart', 18:39:38 INFO - 'tscrollx', 18:39:38 INFO - 'tsvg_static']}, 18:39:38 INFO - 'svgr-stylo-e10s': {'talos_options': ['--stylo'], 18:39:38 INFO - 'tests': ['tsvgx', 18:39:38 INFO - 'tsvgr_opacity', 18:39:38 INFO - 'tart', 18:39:38 INFO - 'tscrollx', 18:39:38 INFO - 'tsvg_static']}, 18:39:38 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 18:39:38 INFO - 'tp5o-stylo-e10s': {'pagesets_name': 'tp5n.zip', 18:39:38 INFO - 'talos_options': ['--stylo'], 18:39:38 INFO - 'tests': ['tp5o']}, 18:39:38 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 18:39:38 INFO - 'talos_options': ['--mitmproxy', 18:39:38 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 18:39:38 INFO - '--firstNonBlankPaint'], 18:39:38 INFO - 'tests': ['tp6_google', 18:39:38 INFO - 'tp6_youtube', 18:39:38 INFO - 'tp6_amazon', 18:39:38 INFO - 'tp6_facebook']}, 18:39:38 INFO - 'tp6-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 18:39:38 INFO - 'talos_options': ['--stylo', 18:39:38 INFO - '--mitmproxy', 18:39:38 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 18:39:38 INFO - '--firstNonBlankPaint'], 18:39:38 INFO - 'tests': ['tp6_google', 18:39:38 INFO - 'tp6_youtube', 18:39:38 INFO - 'tp6_amazon', 18:39:38 INFO - 'tp6_facebook']}, 18:39:38 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 18:39:38 INFO - 'talos_options': ['--stylo', 18:39:38 INFO - '--stylo-threads=1', 18:39:38 INFO - '--mitmproxy', 18:39:38 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 18:39:38 INFO - '--firstNonBlankPaint'], 18:39:38 INFO - 'tests': ['tp6_google', 18:39:38 INFO - 'tp6_youtube', 18:39:38 INFO - 'tp6_amazon', 18:39:38 INFO - 'tp6_facebook']}, 18:39:38 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 18:39:38 INFO - 'talos_options': ['--xperf_path', 18:39:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:39:38 INFO - 'tests': ['tp5n']}, 18:39:38 INFO - 'xperf-stylo-e10s': {'pagesets_name': 'tp5n.zip', 18:39:38 INFO - 'talos_options': ['--stylo', 18:39:38 INFO - '--xperf_path', 18:39:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:39:38 INFO - 'tests': ['tp5n']}}} 18:39:38 INFO - Running post-action listener: _resource_record_post_action 18:39:38 INFO - [mozharness: 2017-08-23 01:39:38.571506Z] Finished populate-webroot step (success) 18:39:38 INFO - [mozharness: 2017-08-23 01:39:38.571594Z] Running create-virtualenv step. 18:39:38 INFO - Running pre-action listener: _resource_record_pre_action 18:39:38 INFO - Running main action method: create_virtualenv 18:39:38 INFO - Creating virtualenv /builds/slave/test/build/venv 18:39:38 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 18:39:38 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:39:38 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 18:39:38 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:39:38 INFO - Using real prefix '/usr' 18:39:38 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:39:39 INFO - Installing distribute.............................................................................................................................................................................................done. 18:39:41 INFO - Installing pip.................done. 18:39:41 INFO - Return code: 0 18:39:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 18:39:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 18:39:41 INFO - Reading from file tmpfile_stdout 18:39:41 INFO - Output received: 18:39:41 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) 18:39:41 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:39:41 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')]} 18:39:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:39:41 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')]} 18:39:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:39:41 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 0xd2d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xef8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x109bf90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1099130>, '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 0x109a030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109a4c0>, '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': 'af724c981e2a0f424dbabf99000001e7-1503452345.248225-1268570157', '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 18:39:41 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 18:39:41 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 18:39:41 INFO - Using env: {'DISPLAY': ':0', 18:39:41 INFO - 'HOME': '/home/cltbld', 18:39:41 INFO - 'LANG': 'en_US.UTF-8', 18:39:41 INFO - 'LANGUAGE': 'en_US:en', 18:39:41 INFO - 'LOGNAME': 'cltbld', 18:39:41 INFO - 'MAIL': '/var/mail/cltbld', 18:39:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:39:41 INFO - 'MOZ_NO_REMOTE': '1', 18:39:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:39:41 INFO - 'NO_EM_RESTART': '1', 18:39:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:39:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:39:41 INFO - 'PWD': '/builds/slave/test', 18:39:41 INFO - 'SHELL': '/bin/bash', 18:39:41 INFO - 'SHLVL': '1', 18:39:41 INFO - 'TERM': 'linux', 18:39:41 INFO - 'TMOUT': '86400', 18:39:41 INFO - 'USER': 'cltbld', 18:39:41 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1503452345.248225-1268570157', 18:39:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:39:41 INFO - '_': '/tools/buildbot/bin/python'} 18:39:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:39:41 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 18:39:41 INFO - Cleaning up... 18:39:41 INFO - Return code: 0 18:39:41 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 18:39:41 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')]} 18:39:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:39:41 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')]} 18:39:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:39:41 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 0xd2d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xef8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x109bf90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1099130>, '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 0x109a030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109a4c0>, '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': 'af724c981e2a0f424dbabf99000001e7-1503452345.248225-1268570157', '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 18:39:41 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 18:39:41 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 18:39:41 INFO - Using env: {'DISPLAY': ':0', 18:39:41 INFO - 'HOME': '/home/cltbld', 18:39:41 INFO - 'LANG': 'en_US.UTF-8', 18:39:41 INFO - 'LANGUAGE': 'en_US:en', 18:39:41 INFO - 'LOGNAME': 'cltbld', 18:39:41 INFO - 'MAIL': '/var/mail/cltbld', 18:39:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:39:41 INFO - 'MOZ_NO_REMOTE': '1', 18:39:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:39:41 INFO - 'NO_EM_RESTART': '1', 18:39:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:39:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:39:41 INFO - 'PWD': '/builds/slave/test', 18:39:41 INFO - 'SHELL': '/bin/bash', 18:39:41 INFO - 'SHLVL': '1', 18:39:41 INFO - 'TERM': 'linux', 18:39:41 INFO - 'TMOUT': '86400', 18:39:41 INFO - 'USER': 'cltbld', 18:39:41 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1503452345.248225-1268570157', 18:39:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:39:41 INFO - '_': '/tools/buildbot/bin/python'} 18:39:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:39:41 INFO - Downloading/unpacking psutil>=3.1.1 18:39:41 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 18:39:41 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 18:39:41 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 18:39:41 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 18:39:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:39:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:39:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:39:43 INFO - Installing collected packages: psutil 18:39:43 INFO - Running setup.py install for psutil 18:39:43 INFO - building 'psutil._psutil_linux' extension 18:39:43 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 18:39:43 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 18:39:43 INFO - building 'psutil._psutil_posix' extension 18:39:43 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 18:39:43 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 18:39:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:39:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:39:43 INFO - Successfully installed psutil 18:39:43 INFO - Cleaning up... 18:39:43 INFO - Return code: 0 18:39:43 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 18:39:43 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')]} 18:39:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:39:43 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')]} 18:39:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:39:43 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 0xd2d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xef8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x109bf90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1099130>, '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 0x109a030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109a4c0>, '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': 'af724c981e2a0f424dbabf99000001e7-1503452345.248225-1268570157', '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 18:39:43 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 18:39:43 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 18:39:43 INFO - Using env: {'DISPLAY': ':0', 18:39:43 INFO - 'HOME': '/home/cltbld', 18:39:43 INFO - 'LANG': 'en_US.UTF-8', 18:39:43 INFO - 'LANGUAGE': 'en_US:en', 18:39:43 INFO - 'LOGNAME': 'cltbld', 18:39:43 INFO - 'MAIL': '/var/mail/cltbld', 18:39:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:39:43 INFO - 'MOZ_NO_REMOTE': '1', 18:39:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:39:43 INFO - 'NO_EM_RESTART': '1', 18:39:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:39:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:39:43 INFO - 'PWD': '/builds/slave/test', 18:39:43 INFO - 'SHELL': '/bin/bash', 18:39:43 INFO - 'SHLVL': '1', 18:39:43 INFO - 'TERM': 'linux', 18:39:43 INFO - 'TMOUT': '86400', 18:39:43 INFO - 'USER': 'cltbld', 18:39:43 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1503452345.248225-1268570157', 18:39:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:39:43 INFO - '_': '/tools/buildbot/bin/python'} 18:39:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:39:43 INFO - Downloading/unpacking mozsystemmonitor==0.3 18:39:43 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 18:39:43 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 18:39:43 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 18:39:43 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 18:39:44 INFO - Downloading mozsystemmonitor-0.3.tar.gz 18:39:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:39:44 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 18:39:44 INFO - Installing collected packages: mozsystemmonitor 18:39:44 INFO - Running setup.py install for mozsystemmonitor 18:39:45 INFO - Successfully installed mozsystemmonitor 18:39:45 INFO - Cleaning up... 18:39:45 INFO - Return code: 0 18:39:45 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 18:39:45 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')]} 18:39:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:39:45 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')]} 18:39:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:39:45 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 0xd2d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xef8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x109bf90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1099130>, '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 0x109a030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109a4c0>, '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': 'af724c981e2a0f424dbabf99000001e7-1503452345.248225-1268570157', '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 18:39:45 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 18:39:45 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 18:39:45 INFO - Using env: {'DISPLAY': ':0', 18:39:45 INFO - 'HOME': '/home/cltbld', 18:39:45 INFO - 'LANG': 'en_US.UTF-8', 18:39:45 INFO - 'LANGUAGE': 'en_US:en', 18:39:45 INFO - 'LOGNAME': 'cltbld', 18:39:45 INFO - 'MAIL': '/var/mail/cltbld', 18:39:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:39:45 INFO - 'MOZ_NO_REMOTE': '1', 18:39:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:39:45 INFO - 'NO_EM_RESTART': '1', 18:39:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:39:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:39:45 INFO - 'PWD': '/builds/slave/test', 18:39:45 INFO - 'SHELL': '/bin/bash', 18:39:45 INFO - 'SHLVL': '1', 18:39:45 INFO - 'TERM': 'linux', 18:39:45 INFO - 'TMOUT': '86400', 18:39:45 INFO - 'USER': 'cltbld', 18:39:45 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1503452345.248225-1268570157', 18:39:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:39:45 INFO - '_': '/tools/buildbot/bin/python'} 18:39:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:39:45 INFO - Downloading/unpacking jsonschema==2.5.1 18:39:45 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 18:39:45 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 18:39:45 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 18:39:45 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 18:39:46 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:39:46 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 18:39:46 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 18:39:46 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 18:39:46 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 18:39:46 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 18:39:46 INFO - Downloading functools32-3.2.3-2.tar.gz 18:39:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:39:46 INFO - warning: no files found matching '*.txt' 18:39:46 INFO - no previously-included directories found matching 'build' 18:39:46 INFO - no previously-included directories found matching 'dist' 18:39:46 INFO - no previously-included directories found matching '.git*' 18:39:46 INFO - Installing collected packages: jsonschema, functools32 18:39:46 INFO - Running setup.py install for functools32 18:39:46 INFO - warning: no files found matching '*.txt' 18:39:46 INFO - no previously-included directories found matching 'build' 18:39:46 INFO - no previously-included directories found matching 'dist' 18:39:46 INFO - no previously-included directories found matching '.git*' 18:39:46 INFO - Successfully installed jsonschema functools32 18:39:46 INFO - Cleaning up... 18:39:46 INFO - Return code: 0 18:39:46 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 18:39:46 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')]} 18:39:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:39:46 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')]} 18:39:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:39:46 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 0xd2d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xef8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x109bf90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1099130>, '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 0x109a030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109a4c0>, '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': 'af724c981e2a0f424dbabf99000001e7-1503452345.248225-1268570157', '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 18:39:46 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 18:39:46 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 18:39:46 INFO - Using env: {'DISPLAY': ':0', 18:39:46 INFO - 'HOME': '/home/cltbld', 18:39:46 INFO - 'LANG': 'en_US.UTF-8', 18:39:46 INFO - 'LANGUAGE': 'en_US:en', 18:39:46 INFO - 'LOGNAME': 'cltbld', 18:39:46 INFO - 'MAIL': '/var/mail/cltbld', 18:39:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:39:46 INFO - 'MOZ_NO_REMOTE': '1', 18:39:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:39:46 INFO - 'NO_EM_RESTART': '1', 18:39:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:39:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:39:46 INFO - 'PWD': '/builds/slave/test', 18:39:46 INFO - 'SHELL': '/bin/bash', 18:39:46 INFO - 'SHLVL': '1', 18:39:46 INFO - 'TERM': 'linux', 18:39:46 INFO - 'TMOUT': '86400', 18:39:46 INFO - 'USER': 'cltbld', 18:39:46 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1503452345.248225-1268570157', 18:39:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:39:46 INFO - '_': '/tools/buildbot/bin/python'} 18:39:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:39:46 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 18:39:46 INFO - Cleaning up... 18:39:47 INFO - Return code: 0 18:39:47 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:39:47 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')]} 18:39:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:39:47 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')]} 18:39:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:39:47 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 0xd2d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xef8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x109bf90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1099130>, '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 0x109a030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109a4c0>, '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': 'af724c981e2a0f424dbabf99000001e7-1503452345.248225-1268570157', '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 18:39:47 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 18:39:47 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 18:39:47 INFO - Using env: {'DISPLAY': ':0', 18:39:47 INFO - 'HOME': '/home/cltbld', 18:39:47 INFO - 'LANG': 'en_US.UTF-8', 18:39:47 INFO - 'LANGUAGE': 'en_US:en', 18:39:47 INFO - 'LOGNAME': 'cltbld', 18:39:47 INFO - 'MAIL': '/var/mail/cltbld', 18:39:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:39:47 INFO - 'MOZ_NO_REMOTE': '1', 18:39:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:39:47 INFO - 'NO_EM_RESTART': '1', 18:39:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:39:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:39:47 INFO - 'PWD': '/builds/slave/test', 18:39:47 INFO - 'SHELL': '/bin/bash', 18:39:47 INFO - 'SHLVL': '1', 18:39:47 INFO - 'TERM': 'linux', 18:39:47 INFO - 'TMOUT': '86400', 18:39:47 INFO - 'USER': 'cltbld', 18:39:47 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1503452345.248225-1268570157', 18:39:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:39:47 INFO - '_': '/tools/buildbot/bin/python'} 18:39:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:39:47 INFO - Downloading/unpacking blobuploader==1.2.4 18:39:47 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 18:39:47 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 18:39:47 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 18:39:47 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 18:39:48 INFO - Downloading blobuploader-1.2.4.tar.gz 18:39:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:39:48 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:39:48 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 18:39:48 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 18:39:48 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 18:39:48 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 18:39:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:39:48 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:39:48 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 18:39:48 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 18:39:48 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 18:39:48 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 18:39:48 INFO - Downloading docopt-0.6.1.tar.gz 18:39:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:39:48 INFO - Installing collected packages: blobuploader, requests, docopt 18:39:48 INFO - Running setup.py install for blobuploader 18:39:49 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:39:49 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:39:49 INFO - Running setup.py install for requests 18:39:49 INFO - Running setup.py install for docopt 18:39:49 INFO - Successfully installed blobuploader requests docopt 18:39:49 INFO - Cleaning up... 18:39:49 INFO - Return code: 0 18:39:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:39:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:39:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:39:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:39:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:39:49 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 0xd2d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xef8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x109bf90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1099130>, '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 0x109a030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109a4c0>, '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': 'af724c981e2a0f424dbabf99000001e7-1503452345.248225-1268570157', '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 18:39:49 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 18:39:49 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 18:39:49 INFO - Using env: {'DISPLAY': ':0', 18:39:49 INFO - 'HOME': '/home/cltbld', 18:39:49 INFO - 'LANG': 'en_US.UTF-8', 18:39:49 INFO - 'LANGUAGE': 'en_US:en', 18:39:49 INFO - 'LOGNAME': 'cltbld', 18:39:49 INFO - 'MAIL': '/var/mail/cltbld', 18:39:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:39:49 INFO - 'MOZ_NO_REMOTE': '1', 18:39:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:39:49 INFO - 'NO_EM_RESTART': '1', 18:39:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:39:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:39:49 INFO - 'PWD': '/builds/slave/test', 18:39:49 INFO - 'SHELL': '/bin/bash', 18:39:49 INFO - 'SHLVL': '1', 18:39:49 INFO - 'TERM': 'linux', 18:39:49 INFO - 'TMOUT': '86400', 18:39:49 INFO - 'USER': 'cltbld', 18:39:49 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1503452345.248225-1268570157', 18:39:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:39:49 INFO - '_': '/tools/buildbot/bin/python'} 18:39:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:39:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:39:49 INFO - Running setup.py (path:/tmp/pip-pUS4jj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:39:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:39:49 INFO - Running setup.py (path:/tmp/pip-hiRDUb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:39:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:39:49 INFO - Running setup.py (path:/tmp/pip-7f4nvb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:39:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:39:49 INFO - Running setup.py (path:/tmp/pip-gEbkqA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:39:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:39:50 INFO - Running setup.py (path:/tmp/pip-CrtdJ5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:39:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:39:50 INFO - Running setup.py (path:/tmp/pip-ATJ2mO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:39:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:39:50 INFO - Running setup.py (path:/tmp/pip-zpkDPJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:39:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:39:50 INFO - Running setup.py (path:/tmp/pip-YLvp3D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:39:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:39:50 INFO - Running setup.py (path:/tmp/pip-NGPxyH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:39:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:39:50 INFO - Running setup.py (path:/tmp/pip-hRIVHa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:39:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:39:50 INFO - Running setup.py (path:/tmp/pip-Tl8_5n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:39:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:39:50 INFO - Running setup.py (path:/tmp/pip-TaumKP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:39:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:39:50 INFO - Running setup.py (path:/tmp/pip-G74XaE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:39:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:39:50 INFO - Running setup.py (path:/tmp/pip-Dl5QCZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:39:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:39:50 INFO - Running setup.py (path:/tmp/pip-lIJwfK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:39:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:39:50 INFO - Running setup.py (path:/tmp/pip-BsrHfM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:39:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:39:50 INFO - Running setup.py (path:/tmp/pip-8lRZNx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:39:50 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:39:50 INFO - Running setup.py install for manifestparser 18:39:51 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:39:51 INFO - Running setup.py install for mozcrash 18:39:51 INFO - Running setup.py install for mozdebug 18:39:51 INFO - Running setup.py install for mozdevice 18:39:51 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:39:51 INFO - Running setup.py install for mozfile 18:39:51 INFO - Running setup.py install for mozhttpd 18:39:51 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:39:51 INFO - Running setup.py install for mozinfo 18:39:51 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:39:51 INFO - Running setup.py install for mozInstall 18:39:51 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:39:51 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:39:51 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:39:51 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:39:51 INFO - Running setup.py install for mozleak 18:39:51 INFO - Running setup.py install for mozlog 18:39:51 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:39:51 INFO - Running setup.py install for moznetwork 18:39:52 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:39:52 INFO - Running setup.py install for mozprocess 18:39:52 INFO - Running setup.py install for mozprofile 18:39:52 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:39:52 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:39:52 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:39:52 INFO - Running setup.py install for mozrunner 18:39:52 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:39:52 INFO - Running setup.py install for mozscreenshot 18:39:52 INFO - Running setup.py install for moztest 18:39:52 INFO - Running setup.py install for mozversion 18:39:52 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:39:52 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:39:52 INFO - Cleaning up... 18:39:52 INFO - Return code: 0 18:39:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:39:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:39:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:39:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:39:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:39:52 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 0xd2d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xef8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x109bf90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1099130>, '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 0x109a030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109a4c0>, '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': 'af724c981e2a0f424dbabf99000001e7-1503452345.248225-1268570157', '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 18:39:52 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 18:39:52 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 18:39:52 INFO - Using env: {'DISPLAY': ':0', 18:39:52 INFO - 'HOME': '/home/cltbld', 18:39:52 INFO - 'LANG': 'en_US.UTF-8', 18:39:52 INFO - 'LANGUAGE': 'en_US:en', 18:39:52 INFO - 'LOGNAME': 'cltbld', 18:39:52 INFO - 'MAIL': '/var/mail/cltbld', 18:39:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:39:52 INFO - 'MOZ_NO_REMOTE': '1', 18:39:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:39:52 INFO - 'NO_EM_RESTART': '1', 18:39:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:39:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:39:52 INFO - 'PWD': '/builds/slave/test', 18:39:52 INFO - 'SHELL': '/bin/bash', 18:39:52 INFO - 'SHLVL': '1', 18:39:52 INFO - 'TERM': 'linux', 18:39:52 INFO - 'TMOUT': '86400', 18:39:52 INFO - 'USER': 'cltbld', 18:39:52 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1503452345.248225-1268570157', 18:39:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:39:52 INFO - '_': '/tools/buildbot/bin/python'} 18:39:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:39:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:39:52 INFO - Running setup.py (path:/tmp/pip-lg5Du9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:39:53 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)) 18:39:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:39:53 INFO - Running setup.py (path:/tmp/pip-2Dlx6l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:39:53 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)) 18:39:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:39:53 INFO - Running setup.py (path:/tmp/pip-dndyss-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:39:53 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)) 18:39:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:39:53 INFO - Running setup.py (path:/tmp/pip-g1Cu_u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:39:53 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)) 18:39:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:39:53 INFO - Running setup.py (path:/tmp/pip-L23bKO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:39:53 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)) 18:39:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:39:53 INFO - Running setup.py (path:/tmp/pip-hPpfVQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:39:53 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)) 18:39:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:39:53 INFO - Running setup.py (path:/tmp/pip-_R9fV_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:39:53 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)) 18:39:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:39:53 INFO - Running setup.py (path:/tmp/pip-hsUnfV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:39:53 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)) 18:39:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:39:53 INFO - Running setup.py (path:/tmp/pip-Sh4FQi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:39:53 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)) 18:39:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:39:53 INFO - Running setup.py (path:/tmp/pip-CwxATH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:39:53 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)) 18:39:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:39:53 INFO - Running setup.py (path:/tmp/pip-V5QVO2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:39:53 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)) 18:39:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:39:53 INFO - Running setup.py (path:/tmp/pip-PHFw6j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:39:53 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)) 18:39:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:39:53 INFO - Running setup.py (path:/tmp/pip-W4Bans-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:39:53 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)) 18:39:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:39:53 INFO - Running setup.py (path:/tmp/pip-JyL6AX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:39:53 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)) 18:39:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:39:53 INFO - Running setup.py (path:/tmp/pip-qvfLhU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:39:54 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)) 18:39:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:39:54 INFO - Running setup.py (path:/tmp/pip-9ke9Sk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:39:54 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)) 18:39:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:39:54 INFO - Running setup.py (path:/tmp/pip-DEWUYZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:39:54 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)) 18:39:54 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)) 18:39:54 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)) 18:39:54 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)) 18:39:54 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)) 18:39:54 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)) 18:39:54 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)) 18:39:54 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:39:54 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 18:39:54 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 18:39:54 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 18:39:54 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 18:39:55 INFO - Downloading blessings-1.6.tar.gz 18:39:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:39:55 INFO - Installing collected packages: blessings 18:39:55 INFO - Running setup.py install for blessings 18:39:55 INFO - Successfully installed blessings 18:39:55 INFO - Cleaning up... 18:39:55 INFO - Return code: 0 18:39:55 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:39:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:39:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:39:55 INFO - Reading from file tmpfile_stdout 18:39:55 INFO - Current package versions: 18:39:55 INFO - argparse == 1.2.1 18:39:55 INFO - blessings == 1.6 18:39:55 INFO - blobuploader == 1.2.4 18:39:55 INFO - docopt == 0.6.1 18:39:55 INFO - functools32 == 3.2.3-2 18:39:55 INFO - jsonschema == 2.5.1 18:39:55 INFO - manifestparser == 1.1 18:39:55 INFO - mozInstall == 1.13 18:39:55 INFO - mozcrash == 1.0 18:39:55 INFO - mozdebug == 0.1 18:39:55 INFO - mozdevice == 0.51 18:39:55 INFO - mozfile == 1.2 18:39:55 INFO - mozhttpd == 0.7 18:39:55 INFO - mozinfo == 0.10 18:39:55 INFO - mozleak == 0.1 18:39:55 INFO - mozlog == 3.5 18:39:55 INFO - moznetwork == 0.27 18:39:55 INFO - mozprocess == 0.25 18:39:55 INFO - mozprofile == 0.28 18:39:55 INFO - mozrunner == 6.13 18:39:55 INFO - mozscreenshot == 0.1 18:39:55 INFO - mozsystemmonitor == 0.3 18:39:55 INFO - moztest == 0.8 18:39:55 INFO - mozversion == 1.4 18:39:55 INFO - psutil == 3.1.1 18:39:55 INFO - requests == 1.2.3 18:39:55 INFO - wsgiref == 0.1.2 18:39:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:39:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:39:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:39:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:39:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:39:55 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 0xd2d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xef8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x109bf90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1099130>, '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 0x109a030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109a4c0>, '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': 'af724c981e2a0f424dbabf99000001e7-1503452345.248225-1268570157', '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 18:39:55 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 18:39:55 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 18:39:55 INFO - Using env: {'DISPLAY': ':0', 18:39:55 INFO - 'HOME': '/home/cltbld', 18:39:55 INFO - 'LANG': 'en_US.UTF-8', 18:39:55 INFO - 'LANGUAGE': 'en_US:en', 18:39:55 INFO - 'LOGNAME': 'cltbld', 18:39:55 INFO - 'MAIL': '/var/mail/cltbld', 18:39:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:39:55 INFO - 'MOZ_NO_REMOTE': '1', 18:39:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:39:55 INFO - 'NO_EM_RESTART': '1', 18:39:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:39:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:39:55 INFO - 'PWD': '/builds/slave/test', 18:39:55 INFO - 'SHELL': '/bin/bash', 18:39:55 INFO - 'SHLVL': '1', 18:39:55 INFO - 'TERM': 'linux', 18:39:55 INFO - 'TMOUT': '86400', 18:39:55 INFO - 'USER': 'cltbld', 18:39:55 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1503452345.248225-1268570157', 18:39:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:39:55 INFO - '_': '/tools/buildbot/bin/python'} 18:39:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:39:55 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)) 18:39:55 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)) 18:39:55 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)) 18:39:55 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)) 18:39:55 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)) 18:39:55 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)) 18:39:55 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)) 18:39:55 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)) 18:39:55 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)) 18:39:55 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 18:39:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:39:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:39:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:39:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:39:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 18:39:57 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)) 18:39:57 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)) 18:39:57 INFO - Installing collected packages: simplejson 18:39:57 INFO - Running setup.py install for simplejson 18:39:57 INFO - building 'simplejson._speedups' extension 18:39:57 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 18:39:58 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 18:39:58 INFO - Successfully installed simplejson 18:39:58 INFO - Cleaning up... 18:39:58 INFO - Return code: 0 18:39:58 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:39:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:39:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:39:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:39:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:39:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd2d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xef8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x109bf90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1099130>, '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 0x109a030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109a4c0>, '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': 'af724c981e2a0f424dbabf99000001e7-1503452345.248225-1268570157', '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 18:39:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 18:39:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 18:39:58 INFO - Using env: {'DISPLAY': ':0', 18:39:58 INFO - 'HOME': '/home/cltbld', 18:39:58 INFO - 'LANG': 'en_US.UTF-8', 18:39:58 INFO - 'LANGUAGE': 'en_US:en', 18:39:58 INFO - 'LOGNAME': 'cltbld', 18:39:58 INFO - 'MAIL': '/var/mail/cltbld', 18:39:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:39:58 INFO - 'MOZ_NO_REMOTE': '1', 18:39:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:39:58 INFO - 'NO_EM_RESTART': '1', 18:39:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:39:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:39:58 INFO - 'PWD': '/builds/slave/test', 18:39:58 INFO - 'SHELL': '/bin/bash', 18:39:58 INFO - 'SHLVL': '1', 18:39:58 INFO - 'TERM': 'linux', 18:39:58 INFO - 'TMOUT': '86400', 18:39:58 INFO - 'USER': 'cltbld', 18:39:58 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1503452345.248225-1268570157', 18:39:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:39:58 INFO - '_': '/tools/buildbot/bin/python'} 18:39:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:39:58 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 18:39:58 INFO - Cleaning up... 18:39:58 INFO - Return code: 0 18:39:58 INFO - Running post-action listener: _resource_record_post_action 18:39:58 INFO - Running post-action listener: _start_resource_monitoring 18:39:58 INFO - Starting resource monitoring. 18:39:58 INFO - [mozharness: 2017-08-23 01:39:58.472822Z] Finished create-virtualenv step (success) 18:39:58 INFO - [mozharness: 2017-08-23 01:39:58.473353Z] Running install step. 18:39:58 INFO - Running pre-action listener: _resource_record_pre_action 18:39:58 INFO - Running main action method: install 18:39:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:39:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:39:58 INFO - Reading from file tmpfile_stdout 18:39:58 INFO - Detecting whether we're running mozinstall >=1.0... 18:39:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:39:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:39:58 INFO - Reading from file tmpfile_stdout 18:39:58 INFO - Output received: 18:39:58 INFO - Usage: mozinstall [options] installer 18:39:58 INFO - Options: 18:39:58 INFO - -h, --help show this help message and exit 18:39:58 INFO - -d DEST, --destination=DEST 18:39:58 INFO - Directory to install application into. [default: 18:39:58 INFO - "/builds/slave/test"] 18:39:58 INFO - --app=APP Application being installed. [default: firefox] 18:39:58 INFO - mkdir: /builds/slave/test/build/application 18:39:58 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'] 18:39:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 18:40:16 INFO - Reading from file tmpfile_stdout 18:40:16 INFO - Output received: 18:40:16 INFO - /builds/slave/test/build/application/firefox/firefox 18:40:16 INFO - Running post-action listener: _resource_record_post_action 18:40:16 INFO - [mozharness: 2017-08-23 01:40:16.503724Z] Finished install step (success) 18:40:16 INFO - [mozharness: 2017-08-23 01:40:16.503977Z] Running setup-mitmproxy step. 18:40:16 INFO - Running pre-action listener: _resource_record_pre_action 18:40:16 INFO - Running main action method: setup_mitmproxy 18:40:16 INFO - Skipping: mitmproxy is not required 18:40:16 INFO - Running post-action listener: _resource_record_post_action 18:40:16 INFO - [mozharness: 2017-08-23 01:40:16.505219Z] Finished setup-mitmproxy step (success) 18:40:16 INFO - [mozharness: 2017-08-23 01:40:16.505440Z] Running run-tests step. 18:40:16 INFO - Running pre-action listener: _resource_record_pre_action 18:40:16 INFO - Running pre-action listener: _set_gcov_prefix 18:40:16 INFO - Running main action method: run_tests 18:40:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:40:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:40:16 INFO - Python 2.7.3 18:40:16 INFO - Return code: 0 18:40:16 INFO - grabbing minidump binary from tooltool 18:40:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:40:16 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 0x1099130>, '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 0x109a030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109a4c0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:40:16 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 18:40:16 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 18:40:16 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 18:40:16 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:40:16 INFO - Return code: 0 18:40:16 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 18:40:16 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:40:16 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:40:16 INFO - ENV: RUST_BACKTRACE is now full 18:40:16 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 18:40:16 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:40:16 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/B13Ixl9iTias4oEEpdFzUg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-020', '--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 18:40:16 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/B13Ixl9iTias4oEEpdFzUg/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-020 --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 18:40:16 INFO - Using env: {'DISPLAY': ':0', 18:40:16 INFO - 'HOME': '/home/cltbld', 18:40:16 INFO - 'LANG': 'en_US.UTF-8', 18:40:16 INFO - 'LANGUAGE': 'en_US:en', 18:40:16 INFO - 'LOGNAME': 'cltbld', 18:40:16 INFO - 'MAIL': '/var/mail/cltbld', 18:40:16 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:40:16 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 18:40:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:40:16 INFO - 'MOZ_NO_REMOTE': '1', 18:40:16 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:40:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:40:16 INFO - 'NO_EM_RESTART': '1', 18:40:16 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:40:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:40:16 INFO - 'PWD': '/builds/slave/test', 18:40:16 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:40:16 INFO - 'RUST_BACKTRACE': 'full', 18:40:16 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 18:40:16 INFO - 'SHELL': '/bin/bash', 18:40:16 INFO - 'SHLVL': '1', 18:40:16 INFO - 'STYLO_FORCE_ENABLED': '1', 18:40:16 INFO - 'TERM': 'linux', 18:40:16 INFO - 'TMOUT': '86400', 18:40:16 INFO - 'USER': 'cltbld', 18:40:16 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1503452345.248225-1268570157', 18:40:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:40:16 INFO - '_': '/tools/buildbot/bin/python'} 18:40:16 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/B13Ixl9iTias4oEEpdFzUg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-020', '--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 18:40:16 INFO - mozversion application_buildid: 20170823004655 18:40:16 INFO - mozversion application_changeset: 7c50f0c999c5bf8ee915261997597a5a9b8fb2ae 18:40:16 INFO - mozversion application_display_name: Nightly 18:40:16 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:40:16 INFO - mozversion application_name: Firefox 18:40:16 INFO - mozversion application_remotingname: firefox 18:40:16 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 18:40:16 INFO - mozversion application_vendor: Mozilla 18:40:16 INFO - mozversion application_version: 57.0a1 18:40:16 INFO - mozversion platform_buildid: 20170823004655 18:40:16 INFO - mozversion platform_changeset: 7c50f0c999c5bf8ee915261997597a5a9b8fb2ae 18:40:16 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 18:40:16 INFO - mozversion platform_version: 57.0a1 18:40:16 INFO - using testdate: 1503452416 18:40:16 INFO - actual date: 1503452416 18:40:16 INFO - starting webserver on 'localhost:33811' 18:40:16 INFO - SUITE-START | Running 2 tests 18:40:16 INFO - TEST-START | dromaeo_css 18:40:16 INFO - Initialising browser for dromaeo_css test... 18:40:16 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:33811/getInfo.html -profile /tmp/tmpH7UrQe/profile 18:40:16 INFO - TEST-INFO | started process 22308 (/builds/slave/test/build/application/firefox/firefox http://localhost:33811/getInfo.html) 18:40:23 INFO - TEST-INFO | 22308: exit 0 18:40:23 INFO - Browser initialized. 18:40:23 INFO - Running cycle 1/1 for dromaeo_css test... 18:40:23 INFO - TEST-INFO | started process 22494 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpH7UrQe/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 18:40:24 INFO - PID 22494 | 18:40:24 INFO - PID 22494 | (/builds/slave/test/build/application/firefox/firefox:22543): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 18:40:24 INFO - PID 22494 | 18:40:25 INFO - PID 22494 | 18:40:25 INFO - PID 22494 | (/builds/slave/test/build/application/firefox/firefox:22602): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 18:40:25 INFO - PID 22494 | 18:40:25 INFO - PID 22494 | __metrics Screen width/height:1600/1200 18:40:25 INFO - PID 22494 | colorDepth:24 18:40:25 INFO - PID 22494 | Browser inner width/height: 1024/768 18:40:25 INFO - PID 22494 | __metrics 18:40:34 INFO - PID 22494 | RSS: Main: 174649344 18:40:34 INFO - PID 22494 | 18:43:33 INFO - PID 22494 | Cycle 1(1): loaded http://localhost:33811/tests/dromaeo/cssquery-dojo.html (next: http://localhost:33811/tests/dromaeo/cssquery-ext.html) 18:43:35 INFO - PID 22494 | RSS: Main: 178667520 18:43:35 INFO - PID 22494 | 18:46:36 INFO - PID 22494 | Cycle 1(1): loaded http://localhost:33811/tests/dromaeo/cssquery-ext.html (next: http://localhost:33811/tests/dromaeo/cssquery-jquery.html) 18:46:37 INFO - PID 22494 | RSS: Main: 175169536 18:46:37 INFO - PID 22494 | 18:49:39 INFO - PID 22494 | Cycle 1(1): loaded http://localhost:33811/tests/dromaeo/cssquery-jquery.html (next: http://localhost:33811/tests/dromaeo/cssquery-mootools.html) 18:49:39 INFO - PID 22494 | RSS: Main: 177369088 18:49:39 INFO - PID 22494 | 18:52:41 INFO - PID 22494 | Cycle 1(1): loaded http://localhost:33811/tests/dromaeo/cssquery-mootools.html (next: http://localhost:33811/tests/dromaeo/cssquery-prototype.html) 18:52:42 INFO - PID 22494 | RSS: Main: 175980544 18:52:42 INFO - PID 22494 | 18:55:46 INFO - PID 22494 | Cycle 1(1): loaded http://localhost:33811/tests/dromaeo/cssquery-prototype.html (next: http://localhost:33811/tests/dromaeo/cssquery-yui.html) 18:55:46 INFO - PID 22494 | RSS: Main: 177885184 18:55:46 INFO - PID 22494 | 18:58:48 INFO - PID 22494 | Cycle 1(1): loaded http://localhost:33811/tests/dromaeo/cssquery-yui.html (next: http://localhost:33811/tests/dromaeo/cssquery-dojo.html) 18:58:48 INFO - PID 22494 | RSS: Main: 179580928 18:58:48 INFO - PID 22494 | 18:58:48 INFO - PID 22494 | __start_tp_report 18:58:48 INFO - PID 22494 | _x_x_mozilla_page_load 18:58:48 INFO - PID 22494 | _x_x_mozilla_page_load_details 18:58:48 INFO - PID 22494 | |i|pagename|runs| 18:58:48 INFO - PID 22494 | |0;dojo.html;3216.6140063192406;3226.4353738095842;3256.234784825566;3263.5757351544294;3273.3126043530856;6168.6607236602085;6244.313125556191;6263.655498947556;6298.023806310023;6347.555671103025;6099.695015249231;6222.533310001745;6222.906656400158;6225.439710426061;6253.937460625392;5710.086386178213;5712.571557133231;5723.027085395493;5751.4248575142365;5757.510611597998;5754.942450575503;5785.623934444268;5856.5021973132125;5859.9414005860035;5886.735096920627;5766.221560089376;5826.883462330751;5846.3861294563885;5858.179854820307;5866.090755932816;5623.381428042912;5732.082866741343;5804.854878628068;5821.039528477796;5852.12218167274;5442.346918369782;5654.6041777075625;5686.5735069869515;5718.170865224519;5736.397678243766;6124.479419249369;6178.474829639486;6204.9689751551405;6240.812775616693;6255.562110652256;6562.80311590653;6637.137172167636;6659.367360100783;6660.533762636617;6765.763198288086;6758.357955994173;6758.662066896635;6769.424598909099;6774.187097548276;6778.457723382117;6204;6219.222597175353;6230.096635987757;6257.624542527463;6264.154339164245;6819.045333653293;6826.24911259761;6828.146481689789;6922.965385173042;6923.238443771181;6504.1869766279215;6561.507886908501;6575.178102737158;6657;6662.733490660319;6683.6658167091455;6755.4257888080065;6761;6766.72933082681;6770.119884414995;6586.440152586988;6592.373724496165;6607.339266073451;6679.465642748569;6688.565243259172;6561.376669216417;6585.670716464253;6635.767748128792;6714.899276510856;6722.193336799615;5171.095058364771;5255.185446255837;5307.230451584499;5368.382635996911;5372.113601255827;4625.190591646448;4638.907221855611;4661.347411362412;4670.509596492388;4701.153792317347;5794.82615521535;5826.94173058264;5864.296284445893;5934.287885453773;5935.40645935403;6706.96646516774;6720.6639668016405;6802.319768023158;6803.693833777492;6823.897641535381;5725.1698503716725;5787.5080618147085;5811.4479124483105;5845.09401042839;5875.529957603467;5808.215890854681;5835.649861008353;5852.239208902815;5872.354041055481;5873.618214816023;6521.119648847345;6551.0500977358015;6595.472362211011;6608.7356505739235;6612.603243805291;6646.966765166143;6747.089142965637;6839.350261725128;6843.0419741237265;6853.17761868579;6363.936360636334;6443.935560644333;6451.580647257913;6481.837954051187;6587.374199451045;6645.867082658417;6648.368405001517;6649.501287403561;6668.299828517936;6710.530262881747;6762.966185169043;6782.559133656297;6841.213260475109;6863.450923926173;6876.656167191721;6499.317571655098;6557.901631475436;6606.900896486461;6618.106555614931;6622.304658010839;6365.1088847562305;6463.57986730861;6473.741050357933;6494.772682956074;6503.317151699003;6399.104125422537;6428.582142160744;6438.452731517874;6510.056041873996;6542.934570654423;6488.318726533835;6559.7376104957175;6561.573497722633;6661.300563440769;6680.365365290289;6327.651979141191;6357.364263573606;6415.679216039272;6430.774922877864;6461.515386345949 18:58:48 INFO - PID 22494 | |1;ext.html;794.4359504751626;845.332187571818;869.5869462005546;1115.0912006714527;1134.285400197875;30150.849245753794;30594.541081883763;30624.234394140156;38758.41862372067;39795.602043979554;40070;40435;40538.79730601343;40558.59441405585;40561;7608;7739.303462688357;7740.380769538451;7754.0695116586085;7792.961035194844;7078.893816592756;7388.113426388814;7691.038620172479;7699.114601820778;7702.422318326148;7685;7696.846063078735;7696.846063078763;7698.538087714727;7701.884471732928;7603.809904752397;7605.087389513294;7618.352440042603;7628;7649.808754781119;7430.108386993596;7518.210587888302;7522.360599349062;7522.586257755821;7539.509931854412;35689;35843.82078089593;35850.28299433997;35918.64081359179;35942.8202858984;3527.5414196154334;3527.9294414111832;3549.432090865475;3566.91082722934;3575.606683264839;30082.24794380136;30150;30219.244518886982;30262.54606180909;30300.24249393783;5158.329417175781;5163.793448262065;5185.714785686786;5204.3234379530795;5204.375474942994;186971;187107;187208;187559;187670.06164969224;44850.55149448529;44958;44990.775046125214;45031.32453013207;45167.54832451699;46258.537414626095;46277.76861115673;46382.30426543605;46484;46544.534554654696;15194.240287985778;15742.527724168292;15744.685106298039;15765.054096754231;15854.762178567331;11356;12930.094893357564;12995.545155919497;13061.608151755463;13065.281409522377;11914.761704765857;13116.409761560753;13155.210687358789;13437.395317210749;13443.731125377437;5306.495882891119;5425.511703946585;5431.701256430855;5444.809431669952;5468.589855760833;995.9442990430167;1008.9445080520642;1009.2228983682523;1022.5602990714065;1025.5487585462522;22534.436639084153;22567.661485077737;22582.0967161315;22774.772252277264;23061;1110.245033377295;1118.765059337532;1121.9551217951355;1127.4531852051748;1134.6255735607394;11890.643280701594;11983.221090629255;12015.699607509881;12265.325407102695;12293.200941938745;226955;227238;228710;229296;229758;50015.24977125273;50418.74790626097;50426.24360634593;50539.49460505421;50564;1428.6356978970296;1443.8483959184134;1457.4316016753476;1458.7811828225852;1463.6633574277762;22678.206262780725;22781.088756449557;22818.65772013388;22987.310380688607;23190.884045579664;36589.26821463609;36592.63407365892;36693;36715.63284367122;36746.63253367539;195046;195520;195598;196636;196940;31469.482441404176;31503.68496315099;31504.842475787475;31742.36515269728;31900;36065.81967090148;37728.2454350906;42582;42625.786871065444;43417.78291108524;30977.845110774302;31294;31468;31543.684563154075;31595.842020790667;30770.538441923836;30793.69206307998;30860.69139308668;31088.22279443032;31605.84197079;33445.33109337848;34759;35011.12472188216;35143.297134057684;35369.115772105906;30171.547426789053;30315.393692126476;30471.238219044702;30587.694123059373;30672.693273066983;22442;22625.434364141027;22891.885540572857;22982.540349193256;23249 18:58:48 INFO - PID 22494 | |2;jquery.html;538.5691446842527;545.6207935484834;551.558752997602;565.0619970848392;567.8779062501561;20909.268175613837;21510.677339839895;21599.244026459077;21680.457988550294;22635.660465092995;23844;24021.879890600565;24302.392440189004;24357.878210608967;24358.63462048071;6345.873082538358;6499.902501462482;6503.837404064912;6503.869922601545;6530.869382612344;5942.6137301075505;6387.297397286295;6464.191976003;6471.352864713538;6483.481321494269;6446.613203207799;6452.225732912034;6459.5478316517865;6465.482761379102;6466.353364663543;6403.327650596713;6422.839429014265;6427.389398007182;6440.1305823713665;6442.065900444456;5984.970075149597;5996.100584912255;6000.159977603139;6005.729742161569;6009.369016253274;27661.170164895084;28470.857645711847;28976.13071607855;29081.272968175752;29325.560116598055;2005.809448102428;2037.02222932993;2037.3582321568658;2037.8165965063067;2038.3782946201402;18989.525261868424;19592.70610940837;19609.705854412194;19609.80390196094;19681.803181968142;2364.1249012878434;2418.480026794248;2427.672264244322;2430.0765709030634;2471.3945083454487;135067;138931;139281.3035934824;139416;139735.30132349374;14200.644983875485;14202.786958195635;14213.64465888361;14661;14932.552023439313;22641.660375094387;22656.320310390714;22723;22724.545509089727;22739.545209096057;9709.757256068513;9885.752856178653;9921.107100360858;10031.398116113056;10033.197344212445;8246.917530824734;8967.148120928501;8994.875640544931;9089.409188402733;9136.908630913606;7914.841703165905;8998.14517620825;9087.772805679911;9152.039035901267;9169.495677737656;2542.4915016996674;2585.1339801166446;2595.117659995573;2601.310652677042;2705.107314586182;963.5423173992298;986.5018165826211;988.6687959533493;993.4982833669095;1006.3458751811235;19448;19476.513087172934;19699.606007879764;19876.900615497118;20302.79697203009;1051.7738686182508;1057.413135709673;1063.5639387850945;1069.7272195590074;1072.292287090532;10832.5125369357;10919.836202456969;10936.56253749857;11028.2280240384;11140.832887506695;458908;473336;477329;482440;483848;104568;106414;106470;108669;109432;1145.4444594371723;1169.3276366089362;1180.3861991764234;1183.0831105893;1185.9644210673694;17202;17304.221310040826;17453.825461745728;17737.37919172823;17779.73330400019;50023.74988125182;51336.486635134665;52544;53329;53514.73242633762;62698.68650656717;63709;63905.36094638994;64518.35481645311;65480;11972.16194866351;12546.1844980076;13727.107737996997;13775.448982041007;14036.649083772987;21822;22155.55688886181;22197.22309719152;22541.549169016198;22553.77446225517;17695.46913592594;17723.556911077325;17998;18017.369392071214;18033.368832090815;15689.529314120595;15720.76418853741;16244.51266462008;16519;16730.24713887902;17932.372366967094;18161.36435224761;18181.727274090634;18325;18467.16897739578;13172.143810652276;13834.723305534035;13967.720645586827;13981.720365592428;13997.300134993005;17125.886817356833;17415.82584174142;17455.738163927806;17513.912430437766;17891.46325610234 18:58:48 INFO - PID 22494 | |3;mootools.html;1279.500994612101;1351.9995203549377;1355.1056302840116;1361.9795703064456;1367.1591970937873;14325.212113333762;14873.330700118493;14923.403063877458;14929.552113436614;14935.701285974288;13699.863001369984;14889.92555037226;14908.776368354456;14985.175815330153;15054;2637.037481319324;2681.463707258556;2682.517146913555;2705.526532856752;2710.7424794644576;2600.739926007403;2777.4306267215175;2779.555271156615;2779.791515636325;2781.8330900146057;2717.171262764866;2727.6726792784893;2730.1263595649402;2755.7106503817013;2763.392053748172;2668.8799004044863;2668.9199324020215;2693.5555633320478;2702.594610808375;2726.7954903382324;2532.075792335803;2587.8188526803133;2591.0542651932096;2601.2846467221666;2605.9348516287055;14444.711105777826;14807.777883331759;14810.259487025605;14820.925895370454;14833.55499335011;7637.618119094079;7843.607819608997;7870.252326029018;7885.842283154305;7899.091604465502;5496.835094947158;5644.548436125141;5684.4315568443235;5685.687287199203;5774.076147816371;1926.9807301926942;1933.6326098041327;1949.2008276606523;1991.332903477337;2001.2195243854908;24703.62944555833;24871.129510467228;24874.37814054645;24890.626640600407;24915.5016899661;6553.475721942234;6770.932290677129;6773.322667733188;6798.932010679929;6800.863982720318;16551.25519351632;16570.337186512646;16644.417445389354;16650.417235396704;16773;7526.5107767994905;7751.108622508371;7900.091489478784;7900.446968712135;7953.6818527258265;5793.131030345482;6071.848203794852;7348.77953661391;7354.043974283416;7370.520916140434;5103.897922041539;5537.778488860481;5618.91571626426;5666.943330566642;5668.603197776116;1699.1843914920908;1742.9041402722971;1755.043501291799;1770.7166853303409;1771.6722406354866;871.5555066915919;897.6858099665195;905.3391024552113;906.0395980260945;906.2795077913075;8331.208535189147;8395.664173433117;8451.619677114544;8512.616932238065;8765.342599305077;949.7055912667096;959.8721502234986;968.080323692495;977.5942983661843;979.7844474215661;5016.313213703064;5050.747462626854;5063.8987220255385;5093.134167191586;5128.9230661540105;19934.60130797376;20312.390628281177;20519.589608207752;20594.176232950515;20714.58570828575;19048.61902761937;19551.120199591052;19756.901215493832;19781.109850056782;19866.60266794656;10843.457827108614;11182.16133789969;11205.383703896201;11209.159313051554;11315.83026254607;7416.851662966603;8049.27556519916;8134.715284964997;8170.714025009096;8290.046644635944;17141.57146071358;17638.11809409499;17665.735013974543;18065.458036258933;18323.083845807923;17753.911230443766;18129.546761331072;18276.634467310847;18409.171587278874;18609.81390186081;11888.821667675165;12062.396880155782;12089.395530223277;12089.455974480994;12106.152569320415;12719.364031798188;12949.870501295243;13046.217226966412;13046.673833154247;13057.738845222852;10770.569177232823;10772.622958196738;10810.621628242974;10977.066949309397;11099.223054386115;10324.277300588887;10418.583256669952;10525.526351314362;10554.155667546424;10557.894421055998;9170.495622740813;9598.520073996411;9749.415035097916;9755.951220243853;9758.170555502862;7239.348458638748;7389.519681220703;7389.963050184715;7460.925390746023;7475.775726728207;6660.83347916306;6816;6833.58998460094;6881.862362752817;6886.931130688629 18:58:48 INFO - PID 22494 | |4;prototype.html;492.0872945389956;504.982728199011;506.3518696069028;515.4948150812205;523.2151772341488;6215.564910456275;6249.843753906154;6276.843078923018;6277.780277690282;6328.905066424008;5977.655027618784;6063.909041364372;6064.241969753781;6121.571489995702;6195.2255968004;4929.334539837112;4976.626752993522;4987.700737955716;4991.450940396553;4995.950040499603;4823.614110871139;4940.580050695695;4972.502749725035;4973.030259099477;4982.327385802906;4901;4915.483874193212;4931.5808156306575;4962.305277261186;4994.200927851544;4881.267809828519;4914.950850491485;4942.481039490837;4963.2058870580895;4976.502349765031;4407.801648925806;4446.644268458515;4455.952851079994;4456;4478.641708663332;6008.026027116562;6014.75940962361;6095.6952152392205;6126.6017708848785;6144.446999770043;5661.575381846378;5688.345840228385;5716.971415142898;5717.714114294268;5725.881423873152;6532.3467653234775;6538.6730663467115;6545.639989800559;6579.243387010507;6590.868182636321;4854.626034905742;4856.514348565151;4858.562729354339;4859.562639362439;4870.318155458239;6849.520533562652;6961.443084553223;6973.755918542877;6990.895136572955;6994.1607007158445;4973.925391119136;4977.228529577848;4982.377202849644;5022.096022715946;5030.597552195815;5051.393832740095;5051.696898186121;5059.56993655536;5068.366454193226;5079.212722028092;5594.860128496739;5669.2346533218315;5683.261176047087;5683.403242659544;5708.600397972102;6500.269886647619;6524.6737663116655;6577.210734711865;6579.30917253691;6692.431143352772;1641.3352592200179;1690.4590531030199;1693.5258127724258;1712.6574685062787;1735.8871673341193;1144.2791041643877;1199.316389657904;1209.38925842449;1214.574898785418;1221.6212973978095;5773.094878690023;5810.767569297265;5832.454399584113;5852.853678658068;5856.970715146482;6590.538662293593;6701.798946031627;6706.128203333633;6714.865702685919;6731.360520750521;5855.3266374367495;5857.824265272048;5873.681370025922;5876.970615146897;5890.970545147333;3556.0398692353438;3591.6767490925417;3592.1558433768046;3600.3159399713973;3613.313470440608;6361.968190159019;6472.967635161888;6528.640924749089;6538.542302038907;6607.933920660828;6846.5892046477375;6878.65606719662;6884.621345826027;6928.946566258795;7000.474964377692;6512.251091124392;6529.7714579990425;6531.575447595891;6588.8352791180605;6599.967000165065;6651;6715.56348837324;6717.059611654275;6729.461643068641;6781.321867813179;6595.868082638224;6624.801255962136;6693.464522838064;6721.1598550181225;6741.73033078691;6393.602399100338;6445.387688169616;6469.994301766467;6528.314526974599;6552.115464412243;4870.12337779189;4907.60739140875;4915.483874193301;4941.925871111865;4961.8511444656715;6696.7656132035145;6707.932920670926;6723.226828914738;6754.696038678369;6775.8142325093895;6483.384078512534;6500.70746816385;6522.608643481406;6570.211574611078;6587.2753997061245;6446.548741588043;6479.5788273762055;6522.739090436519;6541.345865413611;6633.867322653617;5927.8221653350465;6184;6215.96892015537;6300.684965751602;6374.362563743589;6498.187726534184;6508.804735857742;6530.444912182327;6571.671416429063;6607.273199947906;6238.438540531374;6267.686615669107;6345.17512723343;6390.201224846895;6391.488680905423 18:58:48 INFO - PID 22494 | |5;yui.html;886.6054605700461;895.1138373010717;900.4552245891235;911.0707078779645;915.4781774388601;18053.09734513274;19061.904690476546;19090.140943657534;19102.235910563595;20378.082986265617;20007.399778006646;20808.791912080913;20874.26940057098;20907.954602269863;20967.790322096775;922.6678395777515;935.3359115028338;942.0297093993198;942.3121121581249;944.4710961861346;876.837785009772;958.4632605740773;961.9182369498566;963.5567638886121;966.9274804389664;1006.3509036671343;1014.8934361892005;1016.9389836609827;1018.9745256368614;1019.3272440189477;992.9950350248275;1015.0509273828993;1015.0864222200079;1015.1117771949545;1016.5730393234822;723.8407550338917;734.8750712378909;743.3310020981106;744.2371569141619;744.4491076603275;18171.72742408865;18426.35507757222;18888.62222755551;19126.80873191278;19132.426027219066;20300.898495507427;20406.285779997776;20791.16835326585;20791.376258712262;20816;15976.76034859478;16067.83932160675;16096.517104486884;16130.354785808671;16182.83817161825;3716.9070773230615;3780;3785.1483416231404;3788.9810550947345;3793.279276937373;126307.99999999908;126981;128246.35876820557;130857;131362;15300.617484562752;15817.920910395374;15842.207889605474;15848.52454426369;16037;27982.86008569944;29986.25034374158;30451.390972180874;30518;30620.38759224803;7127.96436017827;7506.84986300271;8353.540555269397;8489.575521223915;8798.076201998825;4222.746635201897;4278.935815962763;4313.654907607384;4315.6763242756915;4316.848910288125;4699.765011749399;4947.381577302837;5054;5086.821961231413;5092.567131793765;952.2286947572488;952.3048174832411;973.026973026973;973.3089506450358;974.5273542332105;677.0791723256367;693.6046453521444;702.6802804723839;706.869229192601;709.8899670551073;11327.830082548768;11610.955014048775;11815.822762658567;12108.394580270951;12335.753284934251;702.9086218791524;703.6763088979025;706.5584009993754;707.1055115279175;716.6094478509225;5220.738963051832;5335.413104558495;5383.7846486140115;5415.4313797050745;5459;106121;110506;110862.44568777266;112160.43919780513;113658;94654.52672736593;96724;96726.51636741772;97711.51144244234;98468.50765746126;86890.56554717186;88473;88743.11256887477;89502.55248723846;89509.55245223732;12034.458449369624;12330.75338493243;12461.1900226485;12478.126531142732;12945.54690585825;40288.3956740655;40431;41318.58681413268;41516.79241603894;41576.58423415727;73615.26384736084;75012.62493687497;75242.62378688072;75974.24025759671;76795.2320476788;17942.461726147714;17989.820101799338;18070.36753713614;18378.081095945417;18383.724244136618;20120.19519219215;20384.89807550953;20905.059272333085;20992.370228893156;21046.57906841885;16828.411005614744;17100;17202.397916072878;17220.31118755286;17344.392946246822;17141.48575542736;17615.295388184328;17641.382551610634;17814.554636134202;18499.537511562317;15193.848061519244;15531.301091451138;15567.065976041475;15934.840651593799;18006.189721462826;11902.40487975615;12187.085968552217;12256.264624122581;12336.259824410565;12437.502499899903;13410.664733381744;13505.32473376347;14203.502877399242;14436.206008669204;15224.46714364992 18:58:48 INFO - PID 22494 | __end_tp_report 18:58:48 INFO - PID 22494 | __start_cc_report 18:58:48 INFO - PID 22494 | _x_x_mozilla_cycle_collect,362 18:58:48 INFO - PID 22494 | __end_cc_report 18:58:48 INFO - PID 22494 | __startTimestamp1503453528772__endTimestamp 18:58:48 INFO - PID 22494 | 18:58:48 INFO - PID 22494 | ------- Summary: start ------- 18:58:48 INFO - PID 22494 | Number of tests: 6 18:58:48 INFO - PID 22494 | 18:58:48 INFO - PID 22494 | [#0] dojo.html Cycles:165 Average:6179.69 Median:6430.77 stddev:722.91 (11.2%) stddev-sans-first:686.74 18:58:48 INFO - PID 22494 | Values: 3216.6 3226.4 3256.2 3263.6 3273.3 6168.7 6244.3 6263.7 6298.0 6347.6 6099.7 6222.5 6222.9 6225.4 6253.9 5710.1 5712.6 5723.0 5751.4 5757.5 5754.9 5785.6 5856.5 5859.9 5886.7 5766.2 5826.9 5846.4 5858.2 5866.1 5623.4 5732.1 5804.9 5821.0 5852.1 5442.3 5654.6 5686.6 5718.2 5736.4 6124.5 6178.5 6205.0 6240.8 6255.6 6562.8 6637.1 6659.4 6660.5 6765.8 6758.4 6758.7 6769.4 6774.2 6778.5 6204.0 6219.2 6230.1 6257.6 6264.2 6819.0 6826.2 6828.1 6923.0 6923.2 6504.2 6561.5 6575.2 6657.0 6662.7 6683.7 6755.4 6761.0 6766.7 6770.1 6586.4 6592.4 6607.3 6679.5 6688.6 6561.4 6585.7 6635.8 6714.9 6722.2 5171.1 5255.2 5307.2 5368.4 5372.1 4625.2 4638.9 4661.3 4670.5 4701.2 5794.8 5826.9 5864.3 5934.3 5935.4 6707.0 6720.7 6802.3 6803.7 6823.9 5725.2 5787.5 5811.4 5845.1 5875.5 5808.2 5835.6 5852.2 5872.4 5873.6 6521.1 6551.1 6595.5 6608.7 6612.6 6647.0 6747.1 6839.4 6843.0 6853.2 6363.9 6443.9 6451.6 6481.8 6587.4 6645.9 6648.4 6649.5 6668.3 6710.5 6763.0 6782.6 6841.2 6863.5 6876.7 6499.3 6557.9 6606.9 6618.1 6622.3 6365.1 6463.6 6473.7 6494.8 6503.3 6399.1 6428.6 6438.5 6510.1 6542.9 6488.3 6559.7 6561.6 6661.3 6680.4 6327.7 6357.4 6415.7 6430.8 6461.5 18:58:48 INFO - PID 22494 | 18:58:48 INFO - PID 22494 | [#1] ext.html Cycles:180 Average:36357.89 Median:31600.84 stddev:52983.18 (167.7%) stddev-sans-first:53064.52 18:58:48 INFO - PID 22494 | Values: 794.4 845.3 869.6 1115.1 1134.3 30150.8 30594.5 30624.2 38758.4 39795.6 40070.0 40435.0 40538.8 40558.6 40561.0 7608.0 7739.3 7740.4 7754.1 7793.0 7078.9 7388.1 7691.0 7699.1 7702.4 7685.0 7696.8 7696.8 7698.5 7701.9 7603.8 7605.1 7618.4 7628.0 7649.8 7430.1 7518.2 7522.4 7522.6 7539.5 35689.0 35843.8 35850.3 35918.6 35942.8 3527.5 3527.9 3549.4 3566.9 3575.6 30082.2 30150.0 30219.2 30262.5 30300.2 5158.3 5163.8 5185.7 5204.3 5204.4 186971.0 187107.0 187208.0 187559.0 187670.1 44850.6 44958.0 44990.8 45031.3 45167.5 46258.5 46277.8 46382.3 46484.0 46544.5 15194.2 15742.5 15744.7 15765.1 15854.8 11356.0 12930.1 12995.5 13061.6 13065.3 11914.8 13116.4 13155.2 13437.4 13443.7 5306.5 5425.5 5431.7 5444.8 5468.6 995.9 1008.9 1009.2 1022.6 1025.5 22534.4 22567.7 22582.1 22774.8 23061.0 1110.2 1118.8 1122.0 1127.5 1134.6 11890.6 11983.2 12015.7 12265.3 12293.2 226955.0 227238.0 228710.0 229296.0 229758.0 50015.2 50418.7 50426.2 50539.5 50564.0 1428.6 1443.8 1457.4 1458.8 1463.7 22678.2 22781.1 22818.7 22987.3 23190.9 36589.3 36592.6 36693.0 36715.6 36746.6 195046.0 195520.0 195598.0 196636.0 196940.0 31469.5 31503.7 31504.8 31742.4 31900.0 36065.8 37728.2 42582.0 42625.8 43417.8 30977.8 31294.0 31468.0 31543.7 31595.8 30770.5 30793.7 30860.7 31088.2 31605.8 33445.3 34759.0 35011.1 35143.3 35369.1 30171.5 30315.4 30471.2 30587.7 30672.7 22442.0 22625.4 22891.9 22982.5 23249.0 18:58:48 INFO - PID 22494 | 18:58:48 INFO - PID 22494 | [#2] jquery.html Cycles:180 Average:33489.77 Median:22547.66 stddev:80037.32 (355.0%) stddev-sans-first:80223.61 18:58:48 INFO - PID 22494 | Values: 538.6 545.6 551.6 565.1 567.9 20909.3 21510.7 21599.2 21680.5 22635.7 23844.0 24021.9 24302.4 24357.9 24358.6 6345.9 6499.9 6503.8 6503.9 6530.9 5942.6 6387.3 6464.2 6471.4 6483.5 6446.6 6452.2 6459.5 6465.5 6466.4 6403.3 6422.8 6427.4 6440.1 6442.1 5985.0 5996.1 6000.2 6005.7 6009.4 27661.2 28470.9 28976.1 29081.3 29325.6 2005.8 2037.0 2037.4 2037.8 2038.4 18989.5 19592.7 19609.7 19609.8 19681.8 2364.1 2418.5 2427.7 2430.1 2471.4 135067.0 138931.0 139281.3 139416.0 139735.3 14200.6 14202.8 14213.6 14661.0 14932.6 22641.7 22656.3 22723.0 22724.5 22739.5 9709.8 9885.8 9921.1 10031.4 10033.2 8246.9 8967.1 8994.9 9089.4 9136.9 7914.8 8998.1 9087.8 9152.0 9169.5 2542.5 2585.1 2595.1 2601.3 2705.1 963.5 986.5 988.7 993.5 1006.3 19448.0 19476.5 19699.6 19876.9 20302.8 1051.8 1057.4 1063.6 1069.7 1072.3 10832.5 10919.8 10936.6 11028.2 11140.8 458908.0 473336.0 477329.0 482440.0 483848.0 104568.0 106414.0 106470.0 108669.0 109432.0 1145.4 1169.3 1180.4 1183.1 1186.0 17202.0 17304.2 17453.8 17737.4 17779.7 50023.7 51336.5 52544.0 53329.0 53514.7 62698.7 63709.0 63905.4 64518.4 65480.0 11972.2 12546.2 13727.1 13775.4 14036.6 21822.0 22155.6 22197.2 22541.5 22553.8 17695.5 17723.6 17998.0 18017.4 18033.4 15689.5 15720.8 16244.5 16519.0 16730.2 17932.4 18161.4 18181.7 18325.0 18467.2 13172.1 13834.7 13967.7 13981.7 13997.3 17125.9 17415.8 17455.7 17513.9 17891.5 18:58:48 INFO - PID 22494 | 18:58:48 INFO - PID 22494 | [#3] mootools.html Cycles:180 Average:9037.86 Median:2621.49 stddev:6256.13 (238.6%) stddev-sans-first:6246.52 18:58:48 INFO - PID 22494 | Values: 1279.5 1352.0 1355.1 1362.0 1367.2 14325.2 14873.3 14923.4 14929.6 14935.7 13699.9 14889.9 14908.8 14985.2 15054.0 2637.0 2681.5 2682.5 2705.5 2710.7 2600.7 2777.4 2779.6 2779.8 2781.8 2717.2 2727.7 2730.1 2755.7 2763.4 2668.9 2668.9 2693.6 2702.6 2726.8 2532.1 2587.8 2591.1 2601.3 2605.9 14444.7 14807.8 14810.3 14820.9 14833.6 7637.6 7843.6 7870.3 7885.8 7899.1 5496.8 5644.5 5684.4 5685.7 5774.1 1927.0 1933.6 1949.2 1991.3 2001.2 24703.6 24871.1 24874.4 24890.6 24915.5 6553.5 6770.9 6773.3 6798.9 6800.9 16551.3 16570.3 16644.4 16650.4 16773.0 7526.5 7751.1 7900.1 7900.4 7953.7 5793.1 6071.8 7348.8 7354.0 7370.5 5103.9 5537.8 5618.9 5666.9 5668.6 1699.2 1742.9 1755.0 1770.7 1771.7 871.6 897.7 905.3 906.0 906.3 8331.2 8395.7 8451.6 8512.6 8765.3 949.7 959.9 968.1 977.6 979.8 5016.3 5050.7 5063.9 5093.1 5128.9 19934.6 20312.4 20519.6 20594.2 20714.6 19048.6 19551.1 19756.9 19781.1 19866.6 10843.5 11182.2 11205.4 11209.2 11315.8 7416.9 8049.3 8134.7 8170.7 8290.0 17141.6 17638.1 17665.7 18065.5 18323.1 17753.9 18129.5 18276.6 18409.2 18609.8 11888.8 12062.4 12089.4 12089.5 12106.2 12719.4 12949.9 13046.2 13046.7 13057.7 10770.6 10772.6 10810.6 10977.1 11099.2 10324.3 10418.6 10525.5 10554.2 10557.9 9170.5 9598.5 9749.4 9756.0 9758.2 7239.3 7389.5 7390.0 7460.9 7475.8 6660.8 6816.0 6833.6 6881.9 6886.9 18:58:48 INFO - PID 22494 | 18:58:48 INFO - PID 22494 | [#4] prototype.html Cycles:180 Average:5501.06 Median:6079.97 stddev:1553.06 (25.5%) stddev-sans-first:1511.23 18:58:48 INFO - PID 22494 | Values: 492.1 505.0 506.4 515.5 523.2 6215.6 6249.8 6276.8 6277.8 6328.9 5977.7 6063.9 6064.2 6121.6 6195.2 4929.3 4976.6 4987.7 4991.5 4996.0 4823.6 4940.6 4972.5 4973.0 4982.3 4901.0 4915.5 4931.6 4962.3 4994.2 4881.3 4915.0 4942.5 4963.2 4976.5 4407.8 4446.6 4456.0 4456.0 4478.6 6008.0 6014.8 6095.7 6126.6 6144.4 5661.6 5688.3 5717.0 5717.7 5725.9 6532.3 6538.7 6545.6 6579.2 6590.9 4854.6 4856.5 4858.6 4859.6 4870.3 6849.5 6961.4 6973.8 6990.9 6994.2 4973.9 4977.2 4982.4 5022.1 5030.6 5051.4 5051.7 5059.6 5068.4 5079.2 5594.9 5669.2 5683.3 5683.4 5708.6 6500.3 6524.7 6577.2 6579.3 6692.4 1641.3 1690.5 1693.5 1712.7 1735.9 1144.3 1199.3 1209.4 1214.6 1221.6 5773.1 5810.8 5832.5 5852.9 5857.0 6590.5 6701.8 6706.1 6714.9 6731.4 5855.3 5857.8 5873.7 5877.0 5891.0 3556.0 3591.7 3592.2 3600.3 3613.3 6362.0 6473.0 6528.6 6538.5 6607.9 6846.6 6878.7 6884.6 6928.9 7000.5 6512.3 6529.8 6531.6 6588.8 6600.0 6651.0 6715.6 6717.1 6729.5 6781.3 6595.9 6624.8 6693.5 6721.2 6741.7 6393.6 6445.4 6470.0 6528.3 6552.1 4870.1 4907.6 4915.5 4941.9 4961.9 6696.8 6707.9 6723.2 6754.7 6775.8 6483.4 6500.7 6522.6 6570.2 6587.3 6446.5 6479.6 6522.7 6541.3 6633.9 5927.8 6184.0 6216.0 6300.7 6374.4 6498.2 6508.8 6530.4 6571.7 6607.3 6238.4 6267.7 6345.2 6390.2 6391.5 18:58:48 INFO - PID 22494 | 18:58:48 INFO - PID 22494 | [#5] yui.html Cycles:180 Average:23807.13 Median:20937.87 stddev:32764.46 (156.5%) stddev-sans-first:32811.17 18:58:48 INFO - PID 22494 | Values: 886.6 895.1 900.5 911.1 915.5 18053.1 19061.9 19090.1 19102.2 20378.1 20007.4 20808.8 20874.3 20908.0 20967.8 922.7 935.3 942.0 942.3 944.5 876.8 958.5 961.9 963.6 966.9 1006.4 1014.9 1016.9 1019.0 1019.3 993.0 1015.1 1015.1 1015.1 1016.6 723.8 734.9 743.3 744.2 744.4 18171.7 18426.4 18888.6 19126.8 19132.4 20300.9 20406.3 20791.2 20791.4 20816.0 15976.8 16067.8 16096.5 16130.4 16182.8 3716.9 3780.0 3785.1 3789.0 3793.3 126308.0 126981.0 128246.4 130857.0 131362.0 15300.6 15817.9 15842.2 15848.5 16037.0 27982.9 29986.3 30451.4 30518.0 30620.4 7128.0 7506.8 8353.5 8489.6 8798.1 4222.7 4278.9 4313.7 4315.7 4316.8 4699.8 4947.4 5054.0 5086.8 5092.6 952.2 952.3 973.0 973.3 974.5 677.1 693.6 702.7 706.9 709.9 11327.8 11611.0 11815.8 12108.4 12335.8 702.9 703.7 706.6 707.1 716.6 5220.7 5335.4 5383.8 5415.4 5459.0 106121.0 110506.0 110862.4 112160.4 113658.0 94654.5 96724.0 96726.5 97711.5 98468.5 86890.6 88473.0 88743.1 89502.6 89509.6 12034.5 12330.8 12461.2 12478.1 12945.5 40288.4 40431.0 41318.6 41516.8 41576.6 73615.3 75012.6 75242.6 75974.2 76795.2 17942.5 17989.8 18070.4 18378.1 18383.7 20120.2 20384.9 20905.1 20992.4 21046.6 16828.4 17100.0 17202.4 17220.3 17344.4 17141.5 17615.3 17641.4 17814.6 18499.5 15193.8 15531.3 15567.1 15934.8 18006.2 11902.4 12187.1 12256.3 12336.3 12437.5 13410.7 13505.3 14203.5 14436.2 15224.5 18:58:48 INFO - PID 22494 | -------- Summary: end -------- 18:58:48 INFO - PID 22494 | 18:58:48 INFO - PID 22494 | [Parent 22494] WARNING: pipe error (60): Connection reset by peer: file /home/worker/workspace/build/src/ipc/chromium/src/chrome/common/ipc_channel_posix.cc, line 353 18:58:49 INFO - TEST-INFO | 22494: exit 0 18:58:49 INFO - TEST-OK | dromaeo_css | took 1112621ms 18:58:49 INFO - TEST-START | kraken 18:58:49 INFO - Initialising browser for kraken test... 18:58:49 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:33811/getInfo.html -profile /tmp/tmp0mFjmK/profile 18:58:49 INFO - TEST-INFO | started process 22919 (/builds/slave/test/build/application/firefox/firefox http://localhost:33811/getInfo.html) 18:58:55 INFO - TEST-INFO | 22919: exit 0 18:58:55 INFO - Browser initialized. 18:58:55 INFO - Running cycle 1/1 for kraken test... 18:58:55 INFO - TEST-INFO | started process 23108 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0mFjmK/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 18:58:56 INFO - PID 23108 | 18:58:56 INFO - PID 23108 | (/builds/slave/test/build/application/firefox/firefox:23157): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 18:58:56 INFO - PID 23108 | 18:58:57 INFO - PID 23108 | 18:58:57 INFO - PID 23108 | (/builds/slave/test/build/application/firefox/firefox:23215): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 18:58:57 INFO - PID 23108 | 18:58:57 INFO - PID 23108 | __metrics Screen width/height:1600/1200 18:58:57 INFO - PID 23108 | colorDepth:24 18:58:57 INFO - PID 23108 | Browser inner width/height: 1024/768 18:58:57 INFO - PID 23108 | __metrics 18:59:07 INFO - PID 23108 | RSS: Main: 173555712 18:59:07 INFO - PID 23108 | 18:59:09 INFO - PID 23108 | Cycle 1(1): loaded http://localhost:33811/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:33811/tests/kraken/driver.html?testName=audio-beat-detection) 18:59:10 INFO - PID 23108 | RSS: Main: 177909760 18:59:10 INFO - PID 23108 | 18:59:13 INFO - PID 23108 | Cycle 1(1): loaded http://localhost:33811/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:33811/tests/kraken/driver.html?testName=audio-dft) 18:59:14 INFO - PID 23108 | RSS: Main: 180256768 18:59:14 INFO - PID 23108 | 18:59:17 INFO - PID 23108 | Cycle 1(1): loaded http://localhost:33811/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:33811/tests/kraken/driver.html?testName=audio-fft) 18:59:17 INFO - PID 23108 | RSS: Main: 174903296 18:59:17 INFO - PID 23108 | 18:59:19 INFO - PID 23108 | Cycle 1(1): loaded http://localhost:33811/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:33811/tests/kraken/driver.html?testName=audio-oscillator) 18:59:20 INFO - PID 23108 | RSS: Main: 174768128 18:59:20 INFO - PID 23108 | 18:59:22 INFO - PID 23108 | Cycle 1(1): loaded http://localhost:33811/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:33811/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:59:23 INFO - PID 23108 | RSS: Main: 174989312 18:59:23 INFO - PID 23108 | 18:59:26 INFO - PID 23108 | Cycle 1(1): loaded http://localhost:33811/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:33811/tests/kraken/driver.html?testName=imaging-darkroom) 18:59:27 INFO - PID 23108 | RSS: Main: 176021504 18:59:27 INFO - PID 23108 | 18:59:30 INFO - PID 23108 | Cycle 1(1): loaded http://localhost:33811/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:33811/tests/kraken/driver.html?testName=imaging-desaturate) 18:59:31 INFO - PID 23108 | RSS: Main: 175820800 18:59:31 INFO - PID 23108 | 18:59:34 INFO - PID 23108 | Cycle 1(1): loaded http://localhost:33811/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:33811/tests/kraken/driver.html?testName=json-parse-financial) 18:59:35 INFO - PID 23108 | RSS: Main: 176357376 18:59:35 INFO - PID 23108 | 18:59:36 INFO - PID 23108 | Cycle 1(1): loaded http://localhost:33811/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:33811/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:59:37 INFO - PID 23108 | RSS: Main: 177434624 18:59:37 INFO - PID 23108 | 18:59:39 INFO - PID 23108 | Cycle 1(1): loaded http://localhost:33811/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:33811/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:59:39 INFO - PID 23108 | RSS: Main: 176852992 18:59:39 INFO - PID 23108 | 18:59:42 INFO - PID 23108 | Cycle 1(1): loaded http://localhost:33811/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:33811/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:59:42 INFO - PID 23108 | RSS: Main: 176250880 18:59:42 INFO - PID 23108 | 18:59:45 INFO - PID 23108 | Cycle 1(1): loaded http://localhost:33811/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:33811/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:59:46 INFO - PID 23108 | RSS: Main: 176668672 18:59:46 INFO - PID 23108 | 18:59:49 INFO - PID 23108 | Cycle 1(1): loaded http://localhost:33811/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:33811/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:59:49 INFO - PID 23108 | RSS: Main: 176640000 18:59:49 INFO - PID 23108 | 18:59:51 INFO - PID 23108 | Cycle 1(1): loaded http://localhost:33811/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:33811/tests/kraken/driver.html?testName=ai-astar) 18:59:51 INFO - PID 23108 | RSS: Main: 178434048 18:59:51 INFO - PID 23108 | 18:59:51 INFO - PID 23108 | __start_tp_report 18:59:51 INFO - PID 23108 | _x_x_mozilla_page_load 18:59:51 INFO - PID 23108 | _x_x_mozilla_page_load_details 18:59:51 INFO - PID 23108 | |i|pagename|runs| 18:59:51 INFO - PID 23108 | |0;ai-astar;98;107;102;107;107;109;107;98;107;107 18:59:51 INFO - PID 23108 | |1;audio-beat-detection;147;116;147;180;116;142;146;120;181;118 18:59:51 INFO - PID 23108 | |2;audio-dft;167;160;163;163;162;168;163;164;163;165 18:59:51 INFO - PID 23108 | |3;audio-fft;75;74;74;175;75;75;73;75;156;76 18:59:51 INFO - PID 23108 | |4;audio-oscillator;79;80;136;79;80;80;135;79;78;142 18:59:51 INFO - PID 23108 | |5;imaging-gaussian-blur;117;114;113;113;114;113;114;115;118;114 18:59:51 INFO - PID 23108 | |6;imaging-darkroom;167;148;148;148;148;148;150;148;148;148 18:59:51 INFO - PID 23108 | |7;imaging-desaturate;94;94;99;94;94;94;94;99;103;93 18:59:51 INFO - PID 23108 | |8;json-parse-financial;56;52;54;52;52;52;58;53;56;52 18:59:51 INFO - PID 23108 | |9;json-stringify-tinderbox;63;57;55;62;59;55;56;63;60;55 18:59:51 INFO - PID 23108 | |10;stanford-crypto-aes;74;79;75;74;77;74;80;83;73;74 18:59:51 INFO - PID 23108 | |11;stanford-crypto-ccm;127;126;116;121;121;121;120;131;116;149 18:59:51 INFO - PID 23108 | |12;stanford-crypto-pbkdf2;177;176;168;174;170;168;171;172;172;167 18:59:51 INFO - PID 23108 | |13;stanford-crypto-sha256-iterative;69;64;72;67;66;71;65;66;68;63 18:59:51 INFO - PID 23108 | __end_tp_report 18:59:51 INFO - PID 23108 | __start_cc_report 18:59:51 INFO - PID 23108 | _x_x_mozilla_cycle_collect,963 18:59:51 INFO - PID 23108 | __end_cc_report 18:59:51 INFO - PID 23108 | __startTimestamp1503453591907__endTimestamp 18:59:51 INFO - PID 23108 | 18:59:51 INFO - PID 23108 | ------- Summary: start ------- 18:59:51 INFO - PID 23108 | Number of tests: 14 18:59:51 INFO - PID 23108 | 18:59:51 INFO - PID 23108 | [#0] ai-astar Cycles:10 Average:104.90 Median:107.00 stddev:4.04 (3.8%) stddev-sans-first:3.43 18:59:51 INFO - PID 23108 | Values: 98.0 107.0 102.0 107.0 107.0 109.0 107.0 98.0 107.0 107.0 18:59:51 INFO - PID 23108 | 18:59:51 INFO - PID 23108 | [#1] audio-beat-detection Cycles:10 Average:141.30 Median:146.50 stddev:24.58 (16.8%) stddev-sans-first:25.99 18:59:51 INFO - PID 23108 | Values: 147.0 116.0 147.0 180.0 116.0 142.0 146.0 120.0 181.0 118.0 18:59:51 INFO - PID 23108 | 18:59:51 INFO - PID 23108 | [#2] audio-dft Cycles:10 Average:163.80 Median:163.50 stddev:2.35 (1.4%) stddev-sans-first:2.19 18:59:51 INFO - PID 23108 | Values: 167.0 160.0 163.0 163.0 162.0 168.0 163.0 164.0 163.0 165.0 18:59:51 INFO - PID 23108 | 18:59:51 INFO - PID 23108 | [#3] audio-fft Cycles:10 Average:92.80 Median:75.00 stddev:38.59 (51.4%) stddev-sans-first:40.38 18:59:51 INFO - PID 23108 | Values: 75.0 74.0 74.0 175.0 75.0 75.0 73.0 75.0 156.0 76.0 18:59:51 INFO - PID 23108 | 18:59:51 INFO - PID 23108 | [#4] audio-oscillator Cycles:10 Average:96.80 Median:79.00 stddev:28.26 (35.8%) stddev-sans-first:29.24 18:59:51 INFO - PID 23108 | Values: 79.0 80.0 136.0 79.0 80.0 80.0 135.0 79.0 78.0 142.0 18:59:51 INFO - PID 23108 | 18:59:51 INFO - PID 23108 | [#5] imaging-gaussian-blur Cycles:10 Average:114.50 Median:114.00 stddev:1.72 (1.5%) stddev-sans-first:1.56 18:59:51 INFO - PID 23108 | Values: 117.0 114.0 113.0 113.0 114.0 113.0 114.0 115.0 118.0 114.0 18:59:51 INFO - PID 23108 | 18:59:51 INFO - PID 23108 | [#6] imaging-darkroom Cycles:10 Average:150.10 Median:148.00 stddev:5.97 (4.0%) stddev-sans-first:0.67 18:59:51 INFO - PID 23108 | Values: 167.0 148.0 148.0 148.0 148.0 148.0 150.0 148.0 148.0 148.0 18:59:51 INFO - PID 23108 | 18:59:51 INFO - PID 23108 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:94.00 stddev:3.33 (3.5%) stddev-sans-first:3.46 18:59:51 INFO - PID 23108 | Values: 94.0 94.0 99.0 94.0 94.0 94.0 94.0 99.0 103.0 93.0 18:59:51 INFO - PID 23108 | 18:59:51 INFO - PID 23108 | [#8] json-parse-financial Cycles:10 Average:53.70 Median:53.50 stddev:2.21 (4.1%) stddev-sans-first:2.19 18:59:51 INFO - PID 23108 | Values: 56.0 52.0 54.0 52.0 52.0 52.0 58.0 53.0 56.0 52.0 18:59:51 INFO - PID 23108 | 18:59:51 INFO - PID 23108 | [#9] json-stringify-tinderbox Cycles:10 Average:58.50 Median:59.50 stddev:3.34 (5.6%) stddev-sans-first:3.12 18:59:51 INFO - PID 23108 | Values: 63.0 57.0 55.0 62.0 59.0 55.0 56.0 63.0 60.0 55.0 18:59:51 INFO - PID 23108 | 18:59:51 INFO - PID 23108 | [#10] stanford-crypto-aes Cycles:10 Average:76.30 Median:76.00 stddev:3.33 (4.4%) stddev-sans-first:3.43 18:59:51 INFO - PID 23108 | Values: 74.0 79.0 75.0 74.0 77.0 74.0 80.0 83.0 73.0 74.0 18:59:51 INFO - PID 23108 | 18:59:51 INFO - PID 23108 | [#11] stanford-crypto-ccm Cycles:10 Average:124.80 Median:123.50 stddev:9.73 (7.9%) stddev-sans-first:10.28 18:59:51 INFO - PID 23108 | Values: 127.0 126.0 116.0 121.0 121.0 121.0 120.0 131.0 116.0 149.0 18:59:51 INFO - PID 23108 | 18:59:51 INFO - PID 23108 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:171.50 Median:172.00 stddev:3.41 (2.0%) stddev-sans-first:2.98 18:59:51 INFO - PID 23108 | Values: 177.0 176.0 168.0 174.0 170.0 168.0 171.0 172.0 172.0 167.0 18:59:51 INFO - PID 23108 | 18:59:51 INFO - PID 23108 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.10 Median:67.50 stddev:2.92 (4.3%) stddev-sans-first:3.02 18:59:51 INFO - PID 23108 | Values: 69.0 64.0 72.0 67.0 66.0 71.0 65.0 66.0 68.0 63.0 18:59:51 INFO - PID 23108 | -------- Summary: end -------- 18:59:51 INFO - PID 23108 | 18:59:52 INFO - PID 23108 | 18:59:52 INFO - PID 23108 | ###!!! [Parent][MessageChannel] Error: (msgtype=0x150079,name=PBrowser::Msg_Destroy) Closed channel: cannot send/recv 18:59:52 INFO - PID 23108 | 18:59:52 INFO - PID 23108 | 18:59:52 INFO - PID 23108 | ###!!! [Child][MessageChannel] Error: (msgtype=0x150001,name=PBrowser::Msg_AsyncMessage) Closed channel: cannot send/recv 18:59:52 INFO - PID 23108 | 18:59:52 INFO - PID 23108 | [Parent 23108] WARNING: pipe error (60): Connection reset by peer: file /home/worker/workspace/build/src/ipc/chromium/src/chrome/common/ipc_channel_posix.cc, line 353 18:59:52 INFO - PID 23108 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 18:59:52 INFO - TEST-INFO | 23108: exit 0 18:59:52 INFO - TEST-OK | kraken | took 63404ms 18:59:52 INFO - SUITE-END | took 1176s 18:59:53 INFO - Completed test suite (00:19:36) 18:59:53 INFO - javascript benchmark 18:59:53 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8406.840874140184, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3216.6140063192406, 3226.4353738095842, 3256.234784825566, 3263.5757351544294, 3273.3126043530856, 6168.6607236602085, 6244.313125556191, 6263.655498947556, 6298.023806310023, 6347.555671103025, 6099.695015249231, 6222.533310001745, 6222.906656400158, 6225.439710426061, 6253.937460625392, 5710.086386178213, 5712.571557133231, 5723.027085395493, 5751.4248575142365, 5757.510611597998, 5754.942450575503, 5785.623934444268, 5856.5021973132125, 5859.9414005860035, 5886.735096920627, 5766.221560089376, 5826.883462330751, 5846.3861294563885, 5858.179854820307, 5866.090755932816, 5623.381428042912, 5732.082866741343, 5804.854878628068, 5821.039528477796, 5852.12218167274, 5442.346918369782, 5654.6041777075625, 5686.5735069869515, 5718.170865224519, 5736.397678243766, 6124.479419249369, 6178.474829639486, 6204.9689751551405, 6240.812775616693, 6255.562110652256, 6562.80311590653, 6637.137172167636, 6659.367360100783, 6660.533762636617, 6765.763198288086, 6758.357955994173, 6758.662066896635, 6769.424598909099, 6774.187097548276, 6778.457723382117, 6204.0, 6219.222597175353, 6230.096635987757, 6257.624542527463, 6264.154339164245, 6819.045333653293, 6826.24911259761, 6828.146481689789, 6922.965385173042, 6923.238443771181, 6504.1869766279215, 6561.507886908501, 6575.178102737158, 6657.0, 6662.733490660319, 6683.6658167091455, 6755.4257888080065, 6761.0, 6766.72933082681, 6770.119884414995, 6586.440152586988, 6592.373724496165, 6607.339266073451, 6679.465642748569, 6688.565243259172, 6561.376669216417, 6585.670716464253, 6635.767748128792, 6714.899276510856, 6722.193336799615, 5171.095058364771, 5255.185446255837, 5307.230451584499, 5368.382635996911, 5372.113601255827, 4625.190591646448, 4638.907221855611, 4661.347411362412, 4670.509596492388, 4701.153792317347, 5794.82615521535, 5826.94173058264, 5864.296284445893, 5934.287885453773, 5935.40645935403, 6706.96646516774, 6720.6639668016405, 6802.319768023158, 6803.693833777492, 6823.897641535381, 5725.1698503716725, 5787.5080618147085, 5811.4479124483105, 5845.09401042839, 5875.529957603467, 5808.215890854681, 5835.649861008353, 5852.239208902815, 5872.354041055481, 5873.618214816023, 6521.119648847345, 6551.0500977358015, 6595.472362211011, 6608.7356505739235, 6612.603243805291, 6646.966765166143, 6747.089142965637, 6839.350261725128, 6843.0419741237265, 6853.17761868579, 6363.936360636334, 6443.935560644333, 6451.580647257913, 6481.837954051187, 6587.374199451045, 6645.867082658417, 6648.368405001517, 6649.501287403561, 6668.299828517936, 6710.530262881747, 6762.966185169043, 6782.559133656297, 6841.213260475109, 6863.450923926173, 6876.656167191721, 6499.317571655098, 6557.901631475436, 6606.900896486461, 6618.106555614931, 6622.304658010839, 6365.1088847562305, 6463.57986730861, 6473.741050357933, 6494.772682956074, 6503.317151699003, 6399.104125422537, 6428.582142160744, 6438.452731517874, 6510.056041873996, 6542.934570654423, 6488.318726533835, 6559.7376104957175, 6561.573497722633, 6661.300563440769, 6680.365365290289, 6327.651979141191, 6357.364263573606, 6415.679216039272, 6430.774922877864, 6461.515386345949], "value": 6126.627715091116, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [794.4359504751626, 845.332187571818, 869.5869462005546, 1115.0912006714527, 1134.285400197875, 30150.849245753794, 30594.541081883763, 30624.234394140156, 38758.41862372067, 39795.602043979554, 40070.0, 40435.0, 40538.79730601343, 40558.59441405585, 40561.0, 7608.0, 7739.303462688357, 7740.380769538451, 7754.0695116586085, 7792.961035194844, 7078.893816592756, 7388.113426388814, 7691.038620172479, 7699.114601820778, 7702.422318326148, 7685.0, 7696.846063078735, 7696.846063078763, 7698.538087714727, 7701.884471732928, 7603.809904752397, 7605.087389513294, 7618.352440042603, 7628.0, 7649.808754781119, 7430.108386993596, 7518.210587888302, 7522.360599349062, 7522.586257755821, 7539.509931854412, 35689.0, 35843.82078089593, 35850.28299433997, 35918.64081359179, 35942.8202858984, 3527.5414196154334, 3527.9294414111832, 3549.432090865475, 3566.91082722934, 3575.606683264839, 30082.24794380136, 30150.0, 30219.244518886982, 30262.54606180909, 30300.24249393783, 5158.329417175781, 5163.793448262065, 5185.714785686786, 5204.3234379530795, 5204.375474942994, 186971.0, 187107.0, 187208.0, 187559.0, 187670.06164969224, 44850.55149448529, 44958.0, 44990.775046125214, 45031.32453013207, 45167.54832451699, 46258.537414626095, 46277.76861115673, 46382.30426543605, 46484.0, 46544.534554654696, 15194.240287985778, 15742.527724168292, 15744.685106298039, 15765.054096754231, 15854.762178567331, 11356.0, 12930.094893357564, 12995.545155919497, 13061.608151755463, 13065.281409522377, 11914.761704765857, 13116.409761560753, 13155.210687358789, 13437.395317210749, 13443.731125377437, 5306.495882891119, 5425.511703946585, 5431.701256430855, 5444.809431669952, 5468.589855760833, 995.9442990430167, 1008.9445080520642, 1009.2228983682523, 1022.5602990714065, 1025.5487585462522, 22534.436639084153, 22567.661485077737, 22582.0967161315, 22774.772252277264, 23061.0, 1110.245033377295, 1118.765059337532, 1121.9551217951355, 1127.4531852051748, 1134.6255735607394, 11890.643280701594, 11983.221090629255, 12015.699607509881, 12265.325407102695, 12293.200941938745, 226955.0, 227238.0, 228710.0, 229296.0, 229758.0, 50015.24977125273, 50418.74790626097, 50426.24360634593, 50539.49460505421, 50564.0, 1428.6356978970296, 1443.8483959184134, 1457.4316016753476, 1458.7811828225852, 1463.6633574277762, 22678.206262780725, 22781.088756449557, 22818.65772013388, 22987.310380688607, 23190.884045579664, 36589.26821463609, 36592.63407365892, 36693.0, 36715.63284367122, 36746.63253367539, 195046.0, 195520.0, 195598.0, 196636.0, 196940.0, 31469.482441404176, 31503.68496315099, 31504.842475787475, 31742.36515269728, 31900.0, 36065.81967090148, 37728.2454350906, 42582.0, 42625.786871065444, 43417.78291108524, 30977.845110774302, 31294.0, 31468.0, 31543.684563154075, 31595.842020790667, 30770.538441923836, 30793.69206307998, 30860.69139308668, 31088.22279443032, 31605.84197079, 33445.33109337848, 34759.0, 35011.12472188216, 35143.297134057684, 35369.115772105906, 30171.547426789053, 30315.393692126476, 30471.238219044702, 30587.694123059373, 30672.693273066983, 22442.0, 22625.434364141027, 22891.885540572857, 22982.540349193256, 23249.0], "value": 16653.77292369673, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [538.5691446842527, 545.6207935484834, 551.558752997602, 565.0619970848392, 567.8779062501561, 20909.268175613837, 21510.677339839895, 21599.244026459077, 21680.457988550294, 22635.660465092995, 23844.0, 24021.879890600565, 24302.392440189004, 24357.878210608967, 24358.63462048071, 6345.873082538358, 6499.902501462482, 6503.837404064912, 6503.869922601545, 6530.869382612344, 5942.6137301075505, 6387.297397286295, 6464.191976003, 6471.352864713538, 6483.481321494269, 6446.613203207799, 6452.225732912034, 6459.5478316517865, 6465.482761379102, 6466.353364663543, 6403.327650596713, 6422.839429014265, 6427.389398007182, 6440.1305823713665, 6442.065900444456, 5984.970075149597, 5996.100584912255, 6000.159977603139, 6005.729742161569, 6009.369016253274, 27661.170164895084, 28470.857645711847, 28976.13071607855, 29081.272968175752, 29325.560116598055, 2005.809448102428, 2037.02222932993, 2037.3582321568658, 2037.8165965063067, 2038.3782946201402, 18989.525261868424, 19592.70610940837, 19609.705854412194, 19609.80390196094, 19681.803181968142, 2364.1249012878434, 2418.480026794248, 2427.672264244322, 2430.0765709030634, 2471.3945083454487, 135067.0, 138931.0, 139281.3035934824, 139416.0, 139735.30132349374, 14200.644983875485, 14202.786958195635, 14213.64465888361, 14661.0, 14932.552023439313, 22641.660375094387, 22656.320310390714, 22723.0, 22724.545509089727, 22739.545209096057, 9709.757256068513, 9885.752856178653, 9921.107100360858, 10031.398116113056, 10033.197344212445, 8246.917530824734, 8967.148120928501, 8994.875640544931, 9089.409188402733, 9136.908630913606, 7914.841703165905, 8998.14517620825, 9087.772805679911, 9152.039035901267, 9169.495677737656, 2542.4915016996674, 2585.1339801166446, 2595.117659995573, 2601.310652677042, 2705.107314586182, 963.5423173992298, 986.5018165826211, 988.6687959533493, 993.4982833669095, 1006.3458751811235, 19448.0, 19476.513087172934, 19699.606007879764, 19876.900615497118, 20302.79697203009, 1051.7738686182508, 1057.413135709673, 1063.5639387850945, 1069.7272195590074, 1072.292287090532, 10832.5125369357, 10919.836202456969, 10936.56253749857, 11028.2280240384, 11140.832887506695, 458908.0, 473336.0, 477329.0, 482440.0, 483848.0, 104568.0, 106414.0, 106470.0, 108669.0, 109432.0, 1145.4444594371723, 1169.3276366089362, 1180.3861991764234, 1183.0831105893, 1185.9644210673694, 17202.0, 17304.221310040826, 17453.825461745728, 17737.37919172823, 17779.73330400019, 50023.74988125182, 51336.486635134665, 52544.0, 53329.0, 53514.73242633762, 62698.68650656717, 63709.0, 63905.36094638994, 64518.35481645311, 65480.0, 11972.16194866351, 12546.1844980076, 13727.107737996997, 13775.448982041007, 14036.649083772987, 21822.0, 22155.55688886181, 22197.22309719152, 22541.549169016198, 22553.77446225517, 17695.46913592594, 17723.556911077325, 17998.0, 18017.369392071214, 18033.368832090815, 15689.529314120595, 15720.76418853741, 16244.51266462008, 16519.0, 16730.24713887902, 17932.372366967094, 18161.36435224761, 18181.727274090634, 18325.0, 18467.16897739578, 13172.143810652276, 13834.723305534035, 13967.720645586827, 13981.720365592428, 13997.300134993005, 17125.886817356833, 17415.82584174142, 17455.738163927806, 17513.912430437766, 17891.46325610234], "value": 11624.209510053883, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1279.500994612101, 1351.9995203549377, 1355.1056302840116, 1361.9795703064456, 1367.1591970937873, 14325.212113333762, 14873.330700118493, 14923.403063877458, 14929.552113436614, 14935.701285974288, 13699.863001369984, 14889.92555037226, 14908.776368354456, 14985.175815330153, 15054.0, 2637.037481319324, 2681.463707258556, 2682.517146913555, 2705.526532856752, 2710.7424794644576, 2600.739926007403, 2777.4306267215175, 2779.555271156615, 2779.791515636325, 2781.8330900146057, 2717.171262764866, 2727.6726792784893, 2730.1263595649402, 2755.7106503817013, 2763.392053748172, 2668.8799004044863, 2668.9199324020215, 2693.5555633320478, 2702.594610808375, 2726.7954903382324, 2532.075792335803, 2587.8188526803133, 2591.0542651932096, 2601.2846467221666, 2605.9348516287055, 14444.711105777826, 14807.777883331759, 14810.259487025605, 14820.925895370454, 14833.55499335011, 7637.618119094079, 7843.607819608997, 7870.252326029018, 7885.842283154305, 7899.091604465502, 5496.835094947158, 5644.548436125141, 5684.4315568443235, 5685.687287199203, 5774.076147816371, 1926.9807301926942, 1933.6326098041327, 1949.2008276606523, 1991.332903477337, 2001.2195243854908, 24703.62944555833, 24871.129510467228, 24874.37814054645, 24890.626640600407, 24915.5016899661, 6553.475721942234, 6770.932290677129, 6773.322667733188, 6798.932010679929, 6800.863982720318, 16551.25519351632, 16570.337186512646, 16644.417445389354, 16650.417235396704, 16773.0, 7526.5107767994905, 7751.108622508371, 7900.091489478784, 7900.446968712135, 7953.6818527258265, 5793.131030345482, 6071.848203794852, 7348.77953661391, 7354.043974283416, 7370.520916140434, 5103.897922041539, 5537.778488860481, 5618.91571626426, 5666.943330566642, 5668.603197776116, 1699.1843914920908, 1742.9041402722971, 1755.043501291799, 1770.7166853303409, 1771.6722406354866, 871.5555066915919, 897.6858099665195, 905.3391024552113, 906.0395980260945, 906.2795077913075, 8331.208535189147, 8395.664173433117, 8451.619677114544, 8512.616932238065, 8765.342599305077, 949.7055912667096, 959.8721502234986, 968.080323692495, 977.5942983661843, 979.7844474215661, 5016.313213703064, 5050.747462626854, 5063.8987220255385, 5093.134167191586, 5128.9230661540105, 19934.60130797376, 20312.390628281177, 20519.589608207752, 20594.176232950515, 20714.58570828575, 19048.61902761937, 19551.120199591052, 19756.901215493832, 19781.109850056782, 19866.60266794656, 10843.457827108614, 11182.16133789969, 11205.383703896201, 11209.159313051554, 11315.83026254607, 7416.851662966603, 8049.27556519916, 8134.715284964997, 8170.714025009096, 8290.046644635944, 17141.57146071358, 17638.11809409499, 17665.735013974543, 18065.458036258933, 18323.083845807923, 17753.911230443766, 18129.546761331072, 18276.634467310847, 18409.171587278874, 18609.81390186081, 11888.821667675165, 12062.396880155782, 12089.395530223277, 12089.455974480994, 12106.152569320415, 12719.364031798188, 12949.870501295243, 13046.217226966412, 13046.673833154247, 13057.738845222852, 10770.569177232823, 10772.622958196738, 10810.621628242974, 10977.066949309397, 11099.223054386115, 10324.277300588887, 10418.583256669952, 10525.526351314362, 10554.155667546424, 10557.894421055998, 9170.495622740813, 9598.520073996411, 9749.415035097916, 9755.951220243853, 9758.170555502862, 7239.348458638748, 7389.519681220703, 7389.963050184715, 7460.925390746023, 7475.775726728207, 6660.83347916306, 6816.0, 6833.58998460094, 6881.862362752817, 6886.931130688629], "value": 6576.029967342342, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [492.0872945389956, 504.982728199011, 506.3518696069028, 515.4948150812205, 523.2151772341488, 6215.564910456275, 6249.843753906154, 6276.843078923018, 6277.780277690282, 6328.905066424008, 5977.655027618784, 6063.909041364372, 6064.241969753781, 6121.571489995702, 6195.2255968004, 4929.334539837112, 4976.626752993522, 4987.700737955716, 4991.450940396553, 4995.950040499603, 4823.614110871139, 4940.580050695695, 4972.502749725035, 4973.030259099477, 4982.327385802906, 4901.0, 4915.483874193212, 4931.5808156306575, 4962.305277261186, 4994.200927851544, 4881.267809828519, 4914.950850491485, 4942.481039490837, 4963.2058870580895, 4976.502349765031, 4407.801648925806, 4446.644268458515, 4455.952851079994, 4456.0, 4478.641708663332, 6008.026027116562, 6014.75940962361, 6095.6952152392205, 6126.6017708848785, 6144.446999770043, 5661.575381846378, 5688.345840228385, 5716.971415142898, 5717.714114294268, 5725.881423873152, 6532.3467653234775, 6538.6730663467115, 6545.639989800559, 6579.243387010507, 6590.868182636321, 4854.626034905742, 4856.514348565151, 4858.562729354339, 4859.562639362439, 4870.318155458239, 6849.520533562652, 6961.443084553223, 6973.755918542877, 6990.895136572955, 6994.1607007158445, 4973.925391119136, 4977.228529577848, 4982.377202849644, 5022.096022715946, 5030.597552195815, 5051.393832740095, 5051.696898186121, 5059.56993655536, 5068.366454193226, 5079.212722028092, 5594.860128496739, 5669.2346533218315, 5683.261176047087, 5683.403242659544, 5708.600397972102, 6500.269886647619, 6524.6737663116655, 6577.210734711865, 6579.30917253691, 6692.431143352772, 1641.3352592200179, 1690.4590531030199, 1693.5258127724258, 1712.6574685062787, 1735.8871673341193, 1144.2791041643877, 1199.316389657904, 1209.38925842449, 1214.574898785418, 1221.6212973978095, 5773.094878690023, 5810.767569297265, 5832.454399584113, 5852.853678658068, 5856.970715146482, 6590.538662293593, 6701.798946031627, 6706.128203333633, 6714.865702685919, 6731.360520750521, 5855.3266374367495, 5857.824265272048, 5873.681370025922, 5876.970615146897, 5890.970545147333, 3556.0398692353438, 3591.6767490925417, 3592.1558433768046, 3600.3159399713973, 3613.313470440608, 6361.968190159019, 6472.967635161888, 6528.640924749089, 6538.542302038907, 6607.933920660828, 6846.5892046477375, 6878.65606719662, 6884.621345826027, 6928.946566258795, 7000.474964377692, 6512.251091124392, 6529.7714579990425, 6531.575447595891, 6588.8352791180605, 6599.967000165065, 6651.0, 6715.56348837324, 6717.059611654275, 6729.461643068641, 6781.321867813179, 6595.868082638224, 6624.801255962136, 6693.464522838064, 6721.1598550181225, 6741.73033078691, 6393.602399100338, 6445.387688169616, 6469.994301766467, 6528.314526974599, 6552.115464412243, 4870.12337779189, 4907.60739140875, 4915.483874193301, 4941.925871111865, 4961.8511444656715, 6696.7656132035145, 6707.932920670926, 6723.226828914738, 6754.696038678369, 6775.8142325093895, 6483.384078512534, 6500.70746816385, 6522.608643481406, 6570.211574611078, 6587.2753997061245, 6446.548741588043, 6479.5788273762055, 6522.739090436519, 6541.345865413611, 6633.867322653617, 5927.8221653350465, 6184.0, 6215.96892015537, 6300.684965751602, 6374.362563743589, 6498.187726534184, 6508.804735857742, 6530.444912182327, 6571.671416429063, 6607.273199947906, 6238.438540531374, 6267.686615669107, 6345.17512723343, 6390.201224846895, 6391.488680905423], "value": 5039.961480488852, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [886.6054605700461, 895.1138373010717, 900.4552245891235, 911.0707078779645, 915.4781774388601, 18053.09734513274, 19061.904690476546, 19090.140943657534, 19102.235910563595, 20378.082986265617, 20007.399778006646, 20808.791912080913, 20874.26940057098, 20907.954602269863, 20967.790322096775, 922.6678395777515, 935.3359115028338, 942.0297093993198, 942.3121121581249, 944.4710961861346, 876.837785009772, 958.4632605740773, 961.9182369498566, 963.5567638886121, 966.9274804389664, 1006.3509036671343, 1014.8934361892005, 1016.9389836609827, 1018.9745256368614, 1019.3272440189477, 992.9950350248275, 1015.0509273828993, 1015.0864222200079, 1015.1117771949545, 1016.5730393234822, 723.8407550338917, 734.8750712378909, 743.3310020981106, 744.2371569141619, 744.4491076603275, 18171.72742408865, 18426.35507757222, 18888.62222755551, 19126.80873191278, 19132.426027219066, 20300.898495507427, 20406.285779997776, 20791.16835326585, 20791.376258712262, 20816.0, 15976.76034859478, 16067.83932160675, 16096.517104486884, 16130.354785808671, 16182.83817161825, 3716.9070773230615, 3780.0, 3785.1483416231404, 3788.9810550947345, 3793.279276937373, 126307.99999999908, 126981.0, 128246.35876820557, 130857.0, 131362.0, 15300.617484562752, 15817.920910395374, 15842.207889605474, 15848.52454426369, 16037.0, 27982.86008569944, 29986.25034374158, 30451.390972180874, 30518.0, 30620.38759224803, 7127.96436017827, 7506.84986300271, 8353.540555269397, 8489.575521223915, 8798.076201998825, 4222.746635201897, 4278.935815962763, 4313.654907607384, 4315.6763242756915, 4316.848910288125, 4699.765011749399, 4947.381577302837, 5054.0, 5086.821961231413, 5092.567131793765, 952.2286947572488, 952.3048174832411, 973.026973026973, 973.3089506450358, 974.5273542332105, 677.0791723256367, 693.6046453521444, 702.6802804723839, 706.869229192601, 709.8899670551073, 11327.830082548768, 11610.955014048775, 11815.822762658567, 12108.394580270951, 12335.753284934251, 702.9086218791524, 703.6763088979025, 706.5584009993754, 707.1055115279175, 716.6094478509225, 5220.738963051832, 5335.413104558495, 5383.7846486140115, 5415.4313797050745, 5459.0, 106121.0, 110506.0, 110862.44568777266, 112160.43919780513, 113658.0, 94654.52672736593, 96724.0, 96726.51636741772, 97711.51144244234, 98468.50765746126, 86890.56554717186, 88473.0, 88743.11256887477, 89502.55248723846, 89509.55245223732, 12034.458449369624, 12330.75338493243, 12461.1900226485, 12478.126531142732, 12945.54690585825, 40288.3956740655, 40431.0, 41318.58681413268, 41516.79241603894, 41576.58423415727, 73615.26384736084, 75012.62493687497, 75242.62378688072, 75974.24025759671, 76795.2320476788, 17942.461726147714, 17989.820101799338, 18070.36753713614, 18378.081095945417, 18383.724244136618, 20120.19519219215, 20384.89807550953, 20905.059272333085, 20992.370228893156, 21046.57906841885, 16828.411005614744, 17100.0, 17202.397916072878, 17220.31118755286, 17344.392946246822, 17141.48575542736, 17615.295388184328, 17641.382551610634, 17814.554636134202, 18499.537511562317, 15193.848061519244, 15531.301091451138, 15567.065976041475, 15934.840651593799, 18006.189721462826, 11902.40487975615, 12187.085968552217, 12256.264624122581, 12336.259824410565, 12437.502499899903, 13410.664733381744, 13505.32473376347, 14203.502877399242, 14436.206008669204, 15224.46714364992], "value": 8980.1474488458, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1511.8999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 107.0, 102.0, 107.0, 107.0, 109.0, 107.0, 98.0, 107.0, 107.0], "value": 104.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 116.0, 147.0, 180.0, 116.0, 142.0, 146.0, 120.0, 181.0, 118.0], "value": 141.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 160.0, 163.0, 163.0, 162.0, 168.0, 163.0, 164.0, 163.0, 165.0], "value": 163.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 74.0, 175.0, 75.0, 75.0, 73.0, 75.0, 156.0, 76.0], "value": 92.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 80.0, 136.0, 79.0, 80.0, 80.0, 135.0, 79.0, 78.0, 142.0], "value": 96.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 114.0, 113.0, 113.0, 114.0, 113.0, 114.0, 115.0, 118.0, 114.0], "value": 114.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 148.0, 148.0, 148.0, 148.0, 148.0, 150.0, 148.0, 148.0, 148.0], "value": 150.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 99.0, 94.0, 94.0, 94.0, 94.0, 99.0, 103.0, 93.0], "value": 95.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 52.0, 54.0, 52.0, 52.0, 52.0, 58.0, 53.0, 56.0, 52.0], "value": 53.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 57.0, 55.0, 62.0, 59.0, 55.0, 56.0, 63.0, 60.0, 55.0], "value": 58.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 79.0, 75.0, 74.0, 77.0, 74.0, 80.0, 83.0, 73.0, 74.0], "value": 76.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [127.0, 126.0, 116.0, 121.0, 121.0, 121.0, 120.0, 131.0, 116.0, 149.0], "value": 124.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [177.0, 176.0, 168.0, 174.0, 170.0, 168.0, 171.0, 172.0, 172.0, 167.0], "value": 171.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 64.0, 72.0, 67.0, 66.0, 71.0, 65.0, 66.0, 68.0, 63.0], "value": 67.1, "unit": "score"}]}]} 18:59:53 INFO - Return code: 0 18:59:53 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 18:59:53 INFO - # TBPL SUCCESS # 18:59:53 INFO - Running post-action listener: _package_coverage_data 18:59:53 INFO - Running post-action listener: _resource_record_post_action 18:59:53 INFO - [mozharness: 2017-08-23 01:59:53.197782Z] Finished run-tests step (success) 18:59:53 INFO - Running post-run listener: _resource_record_post_run 18:59:53 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 118784; Write bytes: 452165632; Read time: 464; Write time: 488328 18:59:53 INFO - TinderboxPrint: CPU usage
13.2% 18:59:53 INFO - TinderboxPrint: I/O read bytes / time
118,784 / 464 18:59:53 INFO - TinderboxPrint: I/O write bytes / time
452,165,632 / 488,328 18:59:53 INFO - TinderboxPrint: CPU idle
8,264.7 (86.8%) 18:59:53 INFO - TinderboxPrint: CPU user
1,199.2 (12.6%) 18:59:53 INFO - TinderboxPrint: Swap in / out
0 / 0 18:59:53 INFO - install - Wall time: 18s; CPU: 14.0%; Read bytes: 8192; Write bytes: 115351552; Read time: 144; Write time: 150244 18:59:53 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 18:59:53 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 106496; Write bytes: 335298560; Read time: 308; Write time: 338048 18:59:53 INFO - Running post-run listener: _upload_blobber_files 18:59:53 INFO - Blob upload gear active. 18:59:53 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:59:53 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 18:59:53 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'] 18:59:53 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 18:59:54 INFO - (blobuploader) - INFO - Open directory for files ... 18:59:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 18:59:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:59:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:00:00 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 19:00:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:00:00 INFO - (blobuploader) - INFO - Done attempting. 19:00:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 19:00:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:00:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:00:02 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 19:00:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:00:02 INFO - (blobuploader) - INFO - Done attempting. 19:00:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 19:00:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:00:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:00:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 19:00:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:00:02 INFO - (blobuploader) - INFO - Done attempting. 19:00:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 19:00:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:00:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:00:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 19:00:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:00:03 INFO - (blobuploader) - INFO - Done attempting. 19:00:03 INFO - (blobuploader) - INFO - Iteration through files over. 19:00:03 INFO - Return code: 0 19:00:03 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:00:03 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:00:03 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8d06108b5b748d1e22a6f05fed6aadee8993155b3fd4c23d7ded181f0f270bb56edec28ea81436099321ed8df2e47f04d23e5e5e6053e23179d1a6e9bdca1bfd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e6c3536642c7c306a04fd2d0a853698d85580d0c128e1579c2fc12c8ee235ea3d23e00880b2b91ffb8e6555faf5d30dd3836b43a1e829d0bb3ea875039911ae1", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bdfcb16e23877562d9d01b61af19f2afef525b3bd253d8d0697b84fcbeb18885b3d6ddfa2e38f40121ebfd330de6547e91086ebc3c936e4ca527c388106506d1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4557785340295dc317f13526448cf3162b6b3d9c6be24b7e7ce8c0b8ba4fa5edac4f5dc972af1be772e02ff094865676acfea68474f2640f536ea1bc9e527534"} 19:00:03 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:00:03 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:00:03 INFO - Contents: 19:00:03 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8d06108b5b748d1e22a6f05fed6aadee8993155b3fd4c23d7ded181f0f270bb56edec28ea81436099321ed8df2e47f04d23e5e5e6053e23179d1a6e9bdca1bfd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e6c3536642c7c306a04fd2d0a853698d85580d0c128e1579c2fc12c8ee235ea3d23e00880b2b91ffb8e6555faf5d30dd3836b43a1e829d0bb3ea875039911ae1", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bdfcb16e23877562d9d01b61af19f2afef525b3bd253d8d0697b84fcbeb18885b3d6ddfa2e38f40121ebfd330de6547e91086ebc3c936e4ca527c388106506d1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4557785340295dc317f13526448cf3162b6b3d9c6be24b7e7ce8c0b8ba4fa5edac4f5dc972af1be772e02ff094865676acfea68474f2640f536ea1bc9e527534"} 19:00:03 INFO - Running post-run listener: copy_logs_to_upload_dir 19:00:03 INFO - Copying logs to upload dir... 19:00:03 INFO - mkdir: /builds/slave/test/build/upload/logs 19:00:03 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1256.375880 ========= master_lag: -0.12 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2017-08-22 19:00:03.331877) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-22 19:00:03.338300) ========= 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=af724c981e2a0f424dbabf99000001e7-1503452345.248225-1268570157 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/8d06108b5b748d1e22a6f05fed6aadee8993155b3fd4c23d7ded181f0f270bb56edec28ea81436099321ed8df2e47f04d23e5e5e6053e23179d1a6e9bdca1bfd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e6c3536642c7c306a04fd2d0a853698d85580d0c128e1579c2fc12c8ee235ea3d23e00880b2b91ffb8e6555faf5d30dd3836b43a1e829d0bb3ea875039911ae1", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bdfcb16e23877562d9d01b61af19f2afef525b3bd253d8d0697b84fcbeb18885b3d6ddfa2e38f40121ebfd330de6547e91086ebc3c936e4ca527c388106506d1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4557785340295dc317f13526448cf3162b6b3d9c6be24b7e7ce8c0b8ba4fa5edac4f5dc972af1be772e02ff094865676acfea68474f2640f536ea1bc9e527534"} build_url:https://queue.taskcluster.net/v1/task/B13Ixl9iTias4oEEpdFzUg/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011403 build_url: 'https://queue.taskcluster.net/v1/task/B13Ixl9iTias4oEEpdFzUg/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8d06108b5b748d1e22a6f05fed6aadee8993155b3fd4c23d7ded181f0f270bb56edec28ea81436099321ed8df2e47f04d23e5e5e6053e23179d1a6e9bdca1bfd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e6c3536642c7c306a04fd2d0a853698d85580d0c128e1579c2fc12c8ee235ea3d23e00880b2b91ffb8e6555faf5d30dd3836b43a1e829d0bb3ea875039911ae1", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bdfcb16e23877562d9d01b61af19f2afef525b3bd253d8d0697b84fcbeb18885b3d6ddfa2e38f40121ebfd330de6547e91086ebc3c936e4ca527c388106506d1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4557785340295dc317f13526448cf3162b6b3d9c6be24b7e7ce8c0b8ba4fa5edac4f5dc972af1be772e02ff094865676acfea68474f2640f536ea1bc9e527534"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-22 19:00:03.364344) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-22 19:00:03.364665) ========= 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=af724c981e2a0f424dbabf99000001e7-1503452345.248225-1268570157 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004432 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-22 19:00:03.417763) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-22 19:00:03.418081) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-22 19:00:03.418353) ========= ========= Total master_lag: 0.01 =========