builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-021 starttime: 1507570048.86 results: success (0) revision: b938d2eb9dc9503cc21ba58d3d3db53a45f93c30 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-10-09 10:27:28.861015) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-10-09 10:27:28.861602) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-10-09 10:27:28.861904) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-10-09 10:27:28.906029) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-10-09 10:27:28.906327) ========= 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=df17445c3590ff7897617a0e00000225-1507570017.810534-660076180 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-10-09 10:27:28-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.6M=0s 2017-10-09 10:27:29 (46.6 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.224519 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-10-09 10:27:29.162528) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-10-09 10:27:29.162856) ========= 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=df17445c3590ff7897617a0e00000225-1507570017.810534-660076180 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017452 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-10-09 10:27:29.212365) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-10-09 10:27:29.212699) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev b938d2eb9dc9503cc21ba58d3d3db53a45f93c30 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev b938d2eb9dc9503cc21ba58d3d3db53a45f93c30 --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=df17445c3590ff7897617a0e00000225-1507570017.810534-660076180 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-10-09 10:27:29,266 truncating revision to first 12 chars 2017-10-09 10:27:29,266 Setting DEBUG logging. 2017-10-09 10:27:29,266 attempt 1/10 2017-10-09 10:27:29,266 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/b938d2eb9dc9?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-10-09 10:27:30,321 unpacking tar archive at: mozilla-beta-b938d2eb9dc9/testing/mozharness/ program finished with exit code 0 elapsedTime=1.491142 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-10-09 10:27:30.716344) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-10-09 10:27:30.716662) ========= script_repo_revision: b938d2eb9dc9503cc21ba58d3d3db53a45f93c30 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-10-09 10:27:30.717075) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-10-09 10:27:30.717341) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-10-09 10:27:30.729410) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2017-10-09 10:27:30.729694) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta-Non-PGO 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', 'Mozilla-Beta-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta-Non-PGO'] 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=df17445c3590ff7897617a0e00000225-1507570017.810534-660076180 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:27:32 INFO - MultiFileLogger online at 20171009 10:27:32 in /builds/slave/test 10:27:32 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta-Non-PGO 10:27:32 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:27:32 INFO - {'append_to_log': False, 10:27:32 INFO - 'base_work_dir': '/builds/slave/test', 10:27:32 INFO - 'blob_upload_branch': 'Mozilla-Beta-Non-PGO', 10:27:32 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:27:32 INFO - 'branch': 'Mozilla-Beta-Non-PGO', 10:27:32 INFO - 'buildbot_json_path': 'buildprops.json', 10:27:32 INFO - 'code_coverage': False, 10:27:32 INFO - 'config_files': ('talos/linux_config.py',), 10:27:32 INFO - 'default_actions': ('clobber', 10:27:32 INFO - 'read-buildbot-config', 10:27:32 INFO - 'download-and-extract', 10:27:32 INFO - 'populate-webroot', 10:27:32 INFO - 'create-virtualenv', 10:27:32 INFO - 'install', 10:27:32 INFO - 'setup-mitmproxy', 10:27:32 INFO - 'run-tests'), 10:27:32 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:27:32 INFO - 'disable_ccov_upload': False, 10:27:32 INFO - 'disable_stylo': False, 10:27:32 INFO - 'download_minidump_stackwalk': True, 10:27:32 INFO - 'download_symbols': 'ondemand', 10:27:32 INFO - 'enable_stylo': False, 10:27:32 INFO - 'enable_webrender': False, 10:27:32 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 10:27:32 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:27:32 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:27:32 INFO - 'gecko_profile': False, 10:27:32 INFO - 'gecko_profile_interval': 0, 10:27:32 INFO - 'installer_path': 'installer.exe', 10:27:32 INFO - 'log_level': 'info', 10:27:32 INFO - 'log_name': 'talos', 10:27:32 INFO - 'log_to_console': True, 10:27:32 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:27:32 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:27:32 INFO - 'opt_config_files': (), 10:27:32 INFO - 'pip_index': False, 10:27:32 INFO - 'suite': 'dromaeojs-e10s', 10:27:32 INFO - 'system_bits': '32', 10:27:32 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:27:32 INFO - 'title': 'talos-linux64-ix-021', 10:27:32 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:27:32 INFO - 'use_talos_json': True, 10:27:32 INFO - 'verify': 'False', 10:27:32 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:27:32 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:27:32 INFO - 'work_dir': 'build'} 10:27:32 INFO - [mozharness: 2017-10-09 17:27:32.312498Z] Running clobber step. 10:27:32 INFO - Running pre-action listener: _resource_record_pre_action 10:27:32 INFO - Running main action method: clobber 10:27:32 INFO - rmtree: /builds/slave/test/build 10:27:32 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:27:33 INFO - Running post-action listener: _resource_record_post_action 10:27:33 INFO - [mozharness: 2017-10-09 17:27:33.343960Z] Finished clobber step (success) 10:27:33 INFO - [mozharness: 2017-10-09 17:27:33.344056Z] Running read-buildbot-config step. 10:27:33 INFO - Running pre-action listener: _resource_record_pre_action 10:27:33 INFO - Running main action method: read_buildbot_config 10:27:33 INFO - Using buildbot properties: 10:27:33 INFO - { 10:27:33 INFO - "project": "", 10:27:33 INFO - "product": "firefox", 10:27:33 INFO - "who": "ryanvm@gmail.com", 10:27:33 INFO - "installer_path": "public/build/target.tar.bz2", 10:27:33 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s", 10:27:33 INFO - "repository": "https://hg.mozilla.org/releases/mozilla-beta", 10:27:33 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta talos dromaeojs-e10s", 10:27:33 INFO - "stage_platform": "linux64", 10:27:33 INFO - "basedir": "/builds/slave/test", 10:27:33 INFO - "buildnumber": 128, 10:27:33 INFO - "platform": "ubuntu64_hw", 10:27:33 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 10:27:33 INFO - "slavebuilddir": "test", 10:27:33 INFO - "taskId": "QzHDPeQ1T3igkNCjJnUdhg", 10:27:33 INFO - "branch": "mozilla-beta", 10:27:33 INFO - "script_repo_revision": "production", 10:27:33 INFO - "revision": "b938d2eb9dc9503cc21ba58d3d3db53a45f93c30", 10:27:33 INFO - "slavename": "talos-linux64-ix-021", 10:27:33 INFO - "repo_path": "releases/mozilla-beta" 10:27:33 INFO - } 10:27:33 INFO - Finding installer, test and symbols from parent task. 10:27:33 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/QzHDPeQ1T3igkNCjJnUdhg'}, attempt #1 10:27:33 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/QzHDPeQ1T3igkNCjJnUdhg'}, attempt #1 10:27:34 INFO - Task dependencies: V7HEWaOjRfWkeHPKF2AjDg 10:27:34 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/V7HEWaOjRfWkeHPKF2AjDg'}, attempt #1 10:27:34 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/V7HEWaOjRfWkeHPKF2AjDg/artifacts/public/build/target.tar.bz2 10:27:34 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/V7HEWaOjRfWkeHPKF2AjDg/artifacts/public/build/target.test_packages.json 10:27:34 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/V7HEWaOjRfWkeHPKF2AjDg/artifacts/public/build/target.crashreporter-symbols.zip 10:27:34 INFO - Running post-action listener: _resource_record_post_action 10:27:34 INFO - [mozharness: 2017-10-09 17:27:34.828779Z] Finished read-buildbot-config step (success) 10:27:34 INFO - [mozharness: 2017-10-09 17:27:34.829011Z] Running download-and-extract step. 10:27:34 INFO - Running pre-action listener: _resource_record_pre_action 10:27:34 INFO - Running main action method: download_and_extract 10:27:34 INFO - mkdir: /builds/slave/test/build/tests 10:27:34 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')]} 10:27:34 INFO - trying https://queue.taskcluster.net/v1/task/V7HEWaOjRfWkeHPKF2AjDg/artifacts/public/build/target.test_packages.json 10:27:34 INFO - Downloading https://queue.taskcluster.net/v1/task/V7HEWaOjRfWkeHPKF2AjDg/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 10:27:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/V7HEWaOjRfWkeHPKF2AjDg/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 10:27:35 INFO - Downloaded 989 bytes. 10:27:35 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 10:27:35 INFO - Using the following test package requirements: 10:27:35 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 10:27:35 INFO - u'common': [u'target.common.tests.zip'], 10:27:35 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 10:27:35 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 10:27:35 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 10:27:35 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 10:27:35 INFO - u'mozbase': [u'target.common.tests.zip'], 10:27:35 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 10:27:35 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 10:27:35 INFO - u'web-platform': [u'target.common.tests.zip', 10:27:35 INFO - u'target.web-platform.tests.tar.gz'], 10:27:35 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 10:27:35 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 10:27:35 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/V7HEWaOjRfWkeHPKF2AjDg/artifacts/public/build/target.common.tests.zip 10:27:35 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/V7HEWaOjRfWkeHPKF2AjDg/artifacts/public/build/target.common.tests.zip'}, attempt #1 10:27:35 INFO - Fetch https://queue.taskcluster.net/v1/task/V7HEWaOjRfWkeHPKF2AjDg/artifacts/public/build/target.common.tests.zip into memory 10:27:36 INFO - Content-Length response header: 55180643 10:27:36 INFO - Bytes received: 55180643 10:27:47 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/V7HEWaOjRfWkeHPKF2AjDg/artifacts/public/build/target.talos.tests.zip 10:27:47 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/V7HEWaOjRfWkeHPKF2AjDg/artifacts/public/build/target.talos.tests.zip'}, attempt #1 10:27:47 INFO - Fetch https://queue.taskcluster.net/v1/task/V7HEWaOjRfWkeHPKF2AjDg/artifacts/public/build/target.talos.tests.zip into memory 10:27:48 INFO - Content-Length response header: 14509224 10:27:48 INFO - Bytes received: 14509224 10:27:48 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')]} 10:27:48 INFO - trying https://queue.taskcluster.net/v1/task/V7HEWaOjRfWkeHPKF2AjDg/artifacts/public/build/target.tar.bz2 10:27:48 INFO - Downloading https://queue.taskcluster.net/v1/task/V7HEWaOjRfWkeHPKF2AjDg/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 10:27:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/V7HEWaOjRfWkeHPKF2AjDg/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 10:27:50 INFO - Downloaded 53591551 bytes. 10:27:50 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/V7HEWaOjRfWkeHPKF2AjDg/artifacts/public/build/target.tar.bz2 10:27:50 INFO - mkdir: /builds/slave/test/properties 10:27:50 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:27:50 INFO - Writing to file /builds/slave/test/properties/build_url 10:27:50 INFO - Contents: 10:27:50 INFO - build_url:https://queue.taskcluster.net/v1/task/V7HEWaOjRfWkeHPKF2AjDg/artifacts/public/build/target.tar.bz2 10:27:50 INFO - Running post-action listener: _resource_record_post_action 10:27:50 INFO - Running post-action listener: find_tests_for_verification 10:27:50 INFO - Running post-action listener: set_extra_try_arguments 10:27:50 INFO - [mozharness: 2017-10-09 17:27:50.518478Z] Finished download-and-extract step (success) 10:27:50 INFO - [mozharness: 2017-10-09 17:27:50.518706Z] Running populate-webroot step. 10:27:50 INFO - Running pre-action listener: _resource_record_pre_action 10:27:50 INFO - Running main action method: populate_webroot 10:27:50 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:27:50 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 10:27:50 INFO - 'tests': ['tresize', 10:27:50 INFO - 'tcanvasmark']}, 10:27:50 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:27:50 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 10:27:50 INFO - 'tests': ['dromaeo_css', 10:27:50 INFO - 'kraken']}, 10:27:50 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 10:27:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:27:50 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 10:27:50 INFO - 'talos_options': ['--disable-stylo'], 10:27:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:27:50 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 10:27:50 INFO - 'tests': ['damp', 'tps']}, 10:27:50 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 10:27:50 INFO - 'talos_options': ['--disable-stylo'], 10:27:50 INFO - 'tests': ['damp', 'tps']}, 10:27:50 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:27:50 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 10:27:50 INFO - 'tests': ['dromaeo_dom']}, 10:27:50 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 10:27:50 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 10:27:50 INFO - 'tests': ['basic_compositor_video', 10:27:50 INFO - 'glvideo']}, 10:27:50 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 10:27:50 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 10:27:50 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 10:27:50 INFO - 'talos_options': ['--disable-stylo'], 10:27:50 INFO - 'tests': ['ts_paint_webext', 10:27:50 INFO - 'tp5o_webext']}, 10:27:50 INFO - 'other-e10s': {'tests': ['a11yr', 10:27:50 INFO - 'ts_paint', 10:27:50 INFO - 'tpaint', 10:27:50 INFO - 'sessionrestore', 10:27:50 INFO - 'sessionrestore_many_windows', 10:27:50 INFO - 'sessionrestore_no_auto_restore', 10:27:50 INFO - 'tabpaint']}, 10:27:50 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 10:27:50 INFO - 'tests': ['a11yr', 10:27:50 INFO - 'ts_paint', 10:27:50 INFO - 'tpaint', 10:27:50 INFO - 'sessionrestore', 10:27:50 INFO - 'sessionrestore_many_windows', 10:27:50 INFO - 'sessionrestore_no_auto_restore', 10:27:50 INFO - 'tabpaint']}, 10:27:50 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 10:27:50 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 10:27:50 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 10:27:50 INFO - 'tests': ['perf_reftest_singletons']}, 10:27:50 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 10:27:50 INFO - 'tests': ['bloom_basic']}, 10:27:50 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:27:50 INFO - 'tsvgr_opacity', 10:27:50 INFO - 'tart', 10:27:50 INFO - 'tscrollx', 10:27:50 INFO - 'tsvg_static']}, 10:27:50 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 10:27:50 INFO - 'tests': ['tsvgx', 10:27:50 INFO - 'tsvgr_opacity', 10:27:50 INFO - 'tart', 10:27:50 INFO - 'tscrollx', 10:27:50 INFO - 'tsvg_static']}, 10:27:50 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 10:27:50 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 10:27:50 INFO - 'talos_options': ['--disable-stylo'], 10:27:50 INFO - 'tests': ['tp5o']}, 10:27:50 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 10:27:50 INFO - 'talos_options': ['--mitmproxy', 10:27:50 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 10:27:50 INFO - '--firstNonBlankPaint'], 10:27:50 INFO - 'tests': ['tp6_google', 10:27:50 INFO - 'tp6_youtube', 10:27:50 INFO - 'tp6_amazon', 10:27:50 INFO - 'tp6_facebook']}, 10:27:50 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 10:27:50 INFO - 'talos_options': ['--disable-stylo', 10:27:50 INFO - '--mitmproxy', 10:27:50 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 10:27:50 INFO - '--firstNonBlankPaint'], 10:27:50 INFO - 'tests': ['tp6_google', 10:27:50 INFO - 'tp6_youtube', 10:27:50 INFO - 'tp6_amazon', 10:27:50 INFO - 'tp6_facebook']}, 10:27:50 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 10:27:50 INFO - 'talos_options': ['--stylo-threads=1', 10:27:50 INFO - '--mitmproxy', 10:27:50 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 10:27:50 INFO - '--firstNonBlankPaint'], 10:27:50 INFO - 'tests': ['tp6_google', 10:27:50 INFO - 'tp6_youtube', 10:27:50 INFO - 'tp6_amazon', 10:27:50 INFO - 'tp6_facebook']}, 10:27:50 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 10:27:50 INFO - 'talos_options': ['--xperf_path', 10:27:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:27:50 INFO - 'tests': ['tp5n']}, 10:27:50 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 10:27:50 INFO - 'talos_options': ['--disable-stylo', 10:27:50 INFO - '--xperf_path', 10:27:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:27:50 INFO - 'tests': ['tp5n']}}} 10:27:50 INFO - Running post-action listener: _resource_record_post_action 10:27:50 INFO - [mozharness: 2017-10-09 17:27:50.540261Z] Finished populate-webroot step (success) 10:27:50 INFO - [mozharness: 2017-10-09 17:27:50.540350Z] Running create-virtualenv step. 10:27:50 INFO - Running pre-action listener: _resource_record_pre_action 10:27:50 INFO - Running main action method: create_virtualenv 10:27:50 INFO - Creating virtualenv /builds/slave/test/build/venv 10:27:50 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 10:27:50 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 10:27:50 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 10:27:50 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:27:50 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:27:51 INFO - Installing distribute.............................................................................................................................................................................................done. 10:27:51 INFO - Installing pip...............done. 10:27:51 INFO - Return code: 0 10:27:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 10:27:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 10:27:51 INFO - Reading from file tmpfile_stdout 10:27:51 INFO - Output received: 10:27:51 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 10:27:51 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:27:51 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')]} 10:27:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:27:51 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')]} 10:27:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:27:51 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 0x1a341f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bfca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d9fa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1da3090>, '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 0x1da3d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d9df90>, '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': 'df17445c3590ff7897617a0e00000225-1507570017.810534-660076180', '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 10:27:51 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 10:27:51 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 10:27:51 INFO - Using env: {'DISPLAY': ':0', 10:27:51 INFO - 'HOME': '/home/cltbld', 10:27:51 INFO - 'LANG': 'en_US.UTF-8', 10:27:51 INFO - 'LANGUAGE': 'en_US:en', 10:27:51 INFO - 'LOGNAME': 'cltbld', 10:27:51 INFO - 'MAIL': '/var/mail/cltbld', 10:27:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:27:51 INFO - 'MOZ_NO_REMOTE': '1', 10:27:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:27:51 INFO - 'NO_EM_RESTART': '1', 10:27:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:27:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:27:51 INFO - 'PWD': '/builds/slave/test', 10:27:51 INFO - 'SHELL': '/bin/bash', 10:27:51 INFO - 'SHLVL': '1', 10:27:51 INFO - 'TERM': 'linux', 10:27:51 INFO - 'TMOUT': '86400', 10:27:51 INFO - 'USER': 'cltbld', 10:27:51 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1507570017.810534-660076180', 10:27:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:27:51 INFO - '_': '/tools/buildbot/bin/python'} 10:27:55 INFO - Ignoring indexes: http://pypi.python.org/simple/ 10:27:55 INFO - Downloading/unpacking pip>=1.5 10:27:55 INFO - Running setup.py egg_info for package pip 10:27:55 INFO - warning: no files found matching 'pip/cacert.pem' 10:27:55 INFO - warning: no files found matching '*.html' under directory 'docs' 10:27:55 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 10:27:55 INFO - no previously-included directories found matching 'docs/_build/_sources' 10:27:55 INFO - Installing collected packages: pip 10:27:55 INFO - Found existing installation: pip 1.1 10:27:55 INFO - Uninstalling pip: 10:27:55 INFO - Successfully uninstalled pip 10:27:55 INFO - Running setup.py install for pip 10:27:55 INFO - warning: no files found matching 'pip/cacert.pem' 10:27:55 INFO - warning: no files found matching '*.html' under directory 'docs' 10:27:55 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 10:27:55 INFO - no previously-included directories found matching 'docs/_build/_sources' 10:27:55 INFO - Installing pip script to /builds/slave/test/build/venv/bin 10:27:55 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 10:27:55 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 10:27:55 INFO - Successfully installed pip 10:27:55 INFO - Cleaning up... 10:27:55 INFO - Return code: 0 10:27:55 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:27: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')]} 10:27:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:27: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')]} 10:27:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:27:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a341f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bfca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d9fa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1da3090>, '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 0x1da3d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d9df90>, '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': 'df17445c3590ff7897617a0e00000225-1507570017.810534-660076180', '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 10:27:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 10:27:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 10:27:55 INFO - Using env: {'DISPLAY': ':0', 10:27:55 INFO - 'HOME': '/home/cltbld', 10:27:55 INFO - 'LANG': 'en_US.UTF-8', 10:27:55 INFO - 'LANGUAGE': 'en_US:en', 10:27:55 INFO - 'LOGNAME': 'cltbld', 10:27:55 INFO - 'MAIL': '/var/mail/cltbld', 10:27:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:27:55 INFO - 'MOZ_NO_REMOTE': '1', 10:27:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:27:55 INFO - 'NO_EM_RESTART': '1', 10:27:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:27:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:27:55 INFO - 'PWD': '/builds/slave/test', 10:27:55 INFO - 'SHELL': '/bin/bash', 10:27:55 INFO - 'SHLVL': '1', 10:27:55 INFO - 'TERM': 'linux', 10:27:55 INFO - 'TMOUT': '86400', 10:27:55 INFO - 'USER': 'cltbld', 10:27:55 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1507570017.810534-660076180', 10:27:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:27:55 INFO - '_': '/tools/buildbot/bin/python'} 10:27:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:27:56 INFO - Downloading/unpacking psutil>=3.1.1 10:27:56 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 10:27:56 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 10:27:56 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 10:27:56 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 10:27:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:27:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:27:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:27:57 INFO - Installing collected packages: psutil 10:27:57 INFO - Running setup.py install for psutil 10:27:57 INFO - building 'psutil._psutil_linux' extension 10:27:57 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 10:28:00 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 10:28:00 INFO - building 'psutil._psutil_posix' extension 10:28:00 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 10:28:01 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 10:28:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:28:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:28:01 INFO - Successfully installed psutil 10:28:01 INFO - Cleaning up... 10:28:01 INFO - Return code: 0 10:28:01 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:28:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:28:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:28:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:28:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:28:01 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 0x1a341f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bfca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d9fa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1da3090>, '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 0x1da3d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d9df90>, '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': 'df17445c3590ff7897617a0e00000225-1507570017.810534-660076180', '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 10:28:01 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 10:28:01 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 10:28:01 INFO - Using env: {'DISPLAY': ':0', 10:28:01 INFO - 'HOME': '/home/cltbld', 10:28:01 INFO - 'LANG': 'en_US.UTF-8', 10:28:01 INFO - 'LANGUAGE': 'en_US:en', 10:28:01 INFO - 'LOGNAME': 'cltbld', 10:28:01 INFO - 'MAIL': '/var/mail/cltbld', 10:28:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:28:01 INFO - 'MOZ_NO_REMOTE': '1', 10:28:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:28:01 INFO - 'NO_EM_RESTART': '1', 10:28:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:28:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:28:01 INFO - 'PWD': '/builds/slave/test', 10:28:01 INFO - 'SHELL': '/bin/bash', 10:28:01 INFO - 'SHLVL': '1', 10:28:01 INFO - 'TERM': 'linux', 10:28:01 INFO - 'TMOUT': '86400', 10:28:01 INFO - 'USER': 'cltbld', 10:28:01 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1507570017.810534-660076180', 10:28:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:28:01 INFO - '_': '/tools/buildbot/bin/python'} 10:28:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:28:01 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:28:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:28:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:28:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:28:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:28:02 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:28:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:28:02 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:28:02 INFO - Installing collected packages: mozsystemmonitor 10:28:02 INFO - Running setup.py install for mozsystemmonitor 10:28:02 INFO - Successfully installed mozsystemmonitor 10:28:02 INFO - Cleaning up... 10:28:02 INFO - Return code: 0 10:28:02 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:28:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:28:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:28:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:28:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:28:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1a341f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bfca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d9fa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1da3090>, '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 0x1da3d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d9df90>, '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': 'df17445c3590ff7897617a0e00000225-1507570017.810534-660076180', '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 10:28:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 10:28:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 10:28:02 INFO - Using env: {'DISPLAY': ':0', 10:28:02 INFO - 'HOME': '/home/cltbld', 10:28:02 INFO - 'LANG': 'en_US.UTF-8', 10:28:02 INFO - 'LANGUAGE': 'en_US:en', 10:28:02 INFO - 'LOGNAME': 'cltbld', 10:28:02 INFO - 'MAIL': '/var/mail/cltbld', 10:28:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:28:02 INFO - 'MOZ_NO_REMOTE': '1', 10:28:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:28:02 INFO - 'NO_EM_RESTART': '1', 10:28:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:28:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:28:02 INFO - 'PWD': '/builds/slave/test', 10:28:02 INFO - 'SHELL': '/bin/bash', 10:28:02 INFO - 'SHLVL': '1', 10:28:02 INFO - 'TERM': 'linux', 10:28:02 INFO - 'TMOUT': '86400', 10:28:02 INFO - 'USER': 'cltbld', 10:28:02 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1507570017.810534-660076180', 10:28:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:28:02 INFO - '_': '/tools/buildbot/bin/python'} 10:28:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:28:02 INFO - Downloading/unpacking jsonschema==2.5.1 10:28:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:28:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:28:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:28:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:28:04 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:28:04 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:28:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:28:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:28:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:28:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:28:04 INFO - Downloading functools32-3.2.3-2.tar.gz 10:28:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:28:04 INFO - warning: no files found matching '*.txt' 10:28:04 INFO - no previously-included directories found matching 'build' 10:28:04 INFO - no previously-included directories found matching 'dist' 10:28:04 INFO - no previously-included directories found matching '.git*' 10:28:04 INFO - Installing collected packages: jsonschema, functools32 10:28:04 INFO - Running setup.py install for functools32 10:28:04 INFO - warning: no files found matching '*.txt' 10:28:04 INFO - no previously-included directories found matching 'build' 10:28:04 INFO - no previously-included directories found matching 'dist' 10:28:04 INFO - no previously-included directories found matching '.git*' 10:28:04 INFO - Successfully installed jsonschema functools32 10:28:04 INFO - Cleaning up... 10:28:04 INFO - Return code: 0 10:28:04 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 10:28:04 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')]} 10:28:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:28:04 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')]} 10:28:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:28:04 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 0x1a341f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bfca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d9fa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1da3090>, '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 0x1da3d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d9df90>, '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': 'df17445c3590ff7897617a0e00000225-1507570017.810534-660076180', '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 10:28:04 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 10:28:04 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 10:28:04 INFO - Using env: {'DISPLAY': ':0', 10:28:04 INFO - 'HOME': '/home/cltbld', 10:28:04 INFO - 'LANG': 'en_US.UTF-8', 10:28:04 INFO - 'LANGUAGE': 'en_US:en', 10:28:04 INFO - 'LOGNAME': 'cltbld', 10:28:04 INFO - 'MAIL': '/var/mail/cltbld', 10:28:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:28:04 INFO - 'MOZ_NO_REMOTE': '1', 10:28:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:28:04 INFO - 'NO_EM_RESTART': '1', 10:28:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:28:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:28:04 INFO - 'PWD': '/builds/slave/test', 10:28:04 INFO - 'SHELL': '/bin/bash', 10:28:04 INFO - 'SHLVL': '1', 10:28:04 INFO - 'TERM': 'linux', 10:28:04 INFO - 'TMOUT': '86400', 10:28:04 INFO - 'USER': 'cltbld', 10:28:04 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1507570017.810534-660076180', 10:28:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:28:04 INFO - '_': '/tools/buildbot/bin/python'} 10:28:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:28:04 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 10:28:04 INFO - Cleaning up... 10:28:04 INFO - Return code: 0 10:28:04 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:28:04 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')]} 10:28:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:28:04 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')]} 10:28:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:28:04 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 0x1a341f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bfca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d9fa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1da3090>, '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 0x1da3d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d9df90>, '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': 'df17445c3590ff7897617a0e00000225-1507570017.810534-660076180', '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 10:28:04 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 10:28:04 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 10:28:04 INFO - Using env: {'DISPLAY': ':0', 10:28:04 INFO - 'HOME': '/home/cltbld', 10:28:04 INFO - 'LANG': 'en_US.UTF-8', 10:28:04 INFO - 'LANGUAGE': 'en_US:en', 10:28:04 INFO - 'LOGNAME': 'cltbld', 10:28:04 INFO - 'MAIL': '/var/mail/cltbld', 10:28:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:28:04 INFO - 'MOZ_NO_REMOTE': '1', 10:28:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:28:04 INFO - 'NO_EM_RESTART': '1', 10:28:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:28:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:28:04 INFO - 'PWD': '/builds/slave/test', 10:28:04 INFO - 'SHELL': '/bin/bash', 10:28:04 INFO - 'SHLVL': '1', 10:28:04 INFO - 'TERM': 'linux', 10:28:04 INFO - 'TMOUT': '86400', 10:28:04 INFO - 'USER': 'cltbld', 10:28:04 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1507570017.810534-660076180', 10:28:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:28:04 INFO - '_': '/tools/buildbot/bin/python'} 10:28:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:28:04 INFO - Downloading/unpacking blobuploader==1.2.4 10:28:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:28:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:28:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:28:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:28:06 INFO - Downloading blobuploader-1.2.4.tar.gz 10:28:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:28:06 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:28:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:28:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:28:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:28:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:28:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:28:06 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:28:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:28:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:28:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:28:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:28:06 INFO - Downloading docopt-0.6.1.tar.gz 10:28:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:28:06 INFO - Installing collected packages: blobuploader, requests, docopt 10:28:06 INFO - Running setup.py install for blobuploader 10:28:06 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:28:06 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:28:06 INFO - Running setup.py install for requests 10:28:07 INFO - Running setup.py install for docopt 10:28:07 INFO - Successfully installed blobuploader requests docopt 10:28:07 INFO - Cleaning up... 10:28:07 INFO - Return code: 0 10:28:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:28:07 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')]} 10:28:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:28:07 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')]} 10:28:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:28:07 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 0x1a341f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bfca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d9fa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1da3090>, '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 0x1da3d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d9df90>, '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': 'df17445c3590ff7897617a0e00000225-1507570017.810534-660076180', '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 10:28:07 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 10:28:07 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 10:28:07 INFO - Using env: {'DISPLAY': ':0', 10:28:07 INFO - 'HOME': '/home/cltbld', 10:28:07 INFO - 'LANG': 'en_US.UTF-8', 10:28:07 INFO - 'LANGUAGE': 'en_US:en', 10:28:07 INFO - 'LOGNAME': 'cltbld', 10:28:07 INFO - 'MAIL': '/var/mail/cltbld', 10:28:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:28:07 INFO - 'MOZ_NO_REMOTE': '1', 10:28:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:28:07 INFO - 'NO_EM_RESTART': '1', 10:28:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:28:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:28:07 INFO - 'PWD': '/builds/slave/test', 10:28:07 INFO - 'SHELL': '/bin/bash', 10:28:07 INFO - 'SHLVL': '1', 10:28:07 INFO - 'TERM': 'linux', 10:28:07 INFO - 'TMOUT': '86400', 10:28:07 INFO - 'USER': 'cltbld', 10:28:07 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1507570017.810534-660076180', 10:28:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:28:07 INFO - '_': '/tools/buildbot/bin/python'} 10:28:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:28:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:28:07 INFO - Running setup.py (path:/tmp/pip-YxOG1g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:28:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:28:07 INFO - Running setup.py (path:/tmp/pip-KN3ieN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:28:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:28:07 INFO - Running setup.py (path:/tmp/pip-3oIWJd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:28:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:28:07 INFO - Running setup.py (path:/tmp/pip-aHocZQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:28:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:28:07 INFO - Running setup.py (path:/tmp/pip-zZ9b5g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:28:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:28:07 INFO - Running setup.py (path:/tmp/pip-7FUfMe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:28:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:28:07 INFO - Running setup.py (path:/tmp/pip-jdypSv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:28:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:28:07 INFO - Running setup.py (path:/tmp/pip-gJusMT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:28:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:28:08 INFO - Running setup.py (path:/tmp/pip-GfO611-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:28:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:28:08 INFO - Running setup.py (path:/tmp/pip-uWCZ01-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:28:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:28:08 INFO - Running setup.py (path:/tmp/pip-221zOL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:28:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:28:08 INFO - Running setup.py (path:/tmp/pip-OxlECC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:28:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:28:08 INFO - Running setup.py (path:/tmp/pip-398a1Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:28:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:28:08 INFO - Running setup.py (path:/tmp/pip-6RR1sB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:28:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:28:08 INFO - Running setup.py (path:/tmp/pip-fBpMFj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:28:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:28:08 INFO - Running setup.py (path:/tmp/pip-xAHu3T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:28:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:28:08 INFO - Running setup.py (path:/tmp/pip-HtmFM3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:28:08 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:28:08 INFO - Running setup.py install for manifestparser 10:28:08 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:28:08 INFO - Running setup.py install for mozcrash 10:28:08 INFO - Running setup.py install for mozdebug 10:28:08 INFO - Running setup.py install for mozdevice 10:28:09 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:28:09 INFO - Running setup.py install for mozfile 10:28:09 INFO - Running setup.py install for mozhttpd 10:28:09 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:28:09 INFO - Running setup.py install for mozinfo 10:28:09 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:28:09 INFO - Running setup.py install for mozInstall 10:28:09 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:28:09 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:28:09 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:28:09 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:28:09 INFO - Running setup.py install for mozleak 10:28:09 INFO - Running setup.py install for mozlog 10:28:09 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:28:09 INFO - Running setup.py install for moznetwork 10:28:09 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:28:09 INFO - Running setup.py install for mozprocess 10:28:09 INFO - Running setup.py install for mozprofile 10:28:10 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:28:10 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:28:10 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:28:10 INFO - Running setup.py install for mozrunner 10:28:10 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:28:10 INFO - Running setup.py install for mozscreenshot 10:28:10 INFO - Running setup.py install for moztest 10:28:10 INFO - Running setup.py install for mozversion 10:28:10 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:28:10 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:28:10 INFO - Cleaning up... 10:28:10 INFO - Return code: 0 10:28:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:28: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')]} 10:28:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:28: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')]} 10:28:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:28:10 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 0x1a341f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bfca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d9fa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1da3090>, '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 0x1da3d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d9df90>, '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': 'df17445c3590ff7897617a0e00000225-1507570017.810534-660076180', '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 10:28:10 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 10:28:10 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 10:28:10 INFO - Using env: {'DISPLAY': ':0', 10:28:10 INFO - 'HOME': '/home/cltbld', 10:28:10 INFO - 'LANG': 'en_US.UTF-8', 10:28:10 INFO - 'LANGUAGE': 'en_US:en', 10:28:10 INFO - 'LOGNAME': 'cltbld', 10:28:10 INFO - 'MAIL': '/var/mail/cltbld', 10:28:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:28:10 INFO - 'MOZ_NO_REMOTE': '1', 10:28:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:28:10 INFO - 'NO_EM_RESTART': '1', 10:28:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:28:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:28:10 INFO - 'PWD': '/builds/slave/test', 10:28:10 INFO - 'SHELL': '/bin/bash', 10:28:10 INFO - 'SHLVL': '1', 10:28:10 INFO - 'TERM': 'linux', 10:28:10 INFO - 'TMOUT': '86400', 10:28:10 INFO - 'USER': 'cltbld', 10:28:10 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1507570017.810534-660076180', 10:28:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:28:10 INFO - '_': '/tools/buildbot/bin/python'} 10:28:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:28:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:28:10 INFO - Running setup.py (path:/tmp/pip-VTpDBA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:28:10 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)) 10:28:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:28:10 INFO - Running setup.py (path:/tmp/pip-aouxjR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:28:10 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)) 10:28:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:28:10 INFO - Running setup.py (path:/tmp/pip-D_fC7L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:28:10 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)) 10:28:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:28:10 INFO - Running setup.py (path:/tmp/pip-XrsCQb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:28:10 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)) 10:28:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:28:10 INFO - Running setup.py (path:/tmp/pip-2K1t8c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:28:11 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)) 10:28:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:28:11 INFO - Running setup.py (path:/tmp/pip-nQJMdD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:28:11 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)) 10:28:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:28:11 INFO - Running setup.py (path:/tmp/pip-ovJl4a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:28:11 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)) 10:28:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:28:11 INFO - Running setup.py (path:/tmp/pip-EC9Nlo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:28:11 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)) 10:28:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:28:11 INFO - Running setup.py (path:/tmp/pip-dNBzoZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:28:11 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)) 10:28:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:28:11 INFO - Running setup.py (path:/tmp/pip-qZj6Hh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:28:11 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)) 10:28:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:28:11 INFO - Running setup.py (path:/tmp/pip-VetLCa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:28:11 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)) 10:28:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:28:11 INFO - Running setup.py (path:/tmp/pip-IIyDee-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:28:11 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)) 10:28:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:28:11 INFO - Running setup.py (path:/tmp/pip-qZegp7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:28:11 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)) 10:28:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:28:11 INFO - Running setup.py (path:/tmp/pip-WfhyYe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:28:11 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)) 10:28:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:28:11 INFO - Running setup.py (path:/tmp/pip-XG3qcE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:28:11 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)) 10:28:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:28:11 INFO - Running setup.py (path:/tmp/pip-5u6Jet-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:28:11 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)) 10:28:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:28:11 INFO - Running setup.py (path:/tmp/pip-v4jaZQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:28:11 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)) 10:28:11 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)) 10:28:11 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)) 10:28:11 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)) 10:28:11 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)) 10:28:11 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)) 10:28:11 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)) 10:28:11 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:28:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:28:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:28:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:28:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:28:12 INFO - Downloading blessings-1.6.tar.gz 10:28:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:28:13 INFO - Installing collected packages: blessings 10:28:13 INFO - Running setup.py install for blessings 10:28:13 INFO - Successfully installed blessings 10:28:13 INFO - Cleaning up... 10:28:13 INFO - Return code: 0 10:28:13 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:28:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:28:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:28:13 INFO - Reading from file tmpfile_stdout 10:28:13 INFO - Current package versions: 10:28:13 INFO - argparse == 1.2.1 10:28:13 INFO - blessings == 1.6 10:28:13 INFO - blobuploader == 1.2.4 10:28:13 INFO - docopt == 0.6.1 10:28:13 INFO - functools32 == 3.2.3-2 10:28:13 INFO - jsonschema == 2.5.1 10:28:13 INFO - manifestparser == 1.1 10:28:13 INFO - mozInstall == 1.13 10:28:13 INFO - mozcrash == 1.0 10:28:13 INFO - mozdebug == 0.1 10:28:13 INFO - mozdevice == 0.51 10:28:13 INFO - mozfile == 1.2 10:28:13 INFO - mozhttpd == 0.7 10:28:13 INFO - mozinfo == 0.10 10:28:13 INFO - mozleak == 0.1 10:28:13 INFO - mozlog == 3.5 10:28:13 INFO - moznetwork == 0.27 10:28:13 INFO - mozprocess == 0.25 10:28:13 INFO - mozprofile == 0.28 10:28:13 INFO - mozrunner == 6.13 10:28:13 INFO - mozscreenshot == 0.1 10:28:13 INFO - mozsystemmonitor == 0.3 10:28:13 INFO - moztest == 0.8 10:28:13 INFO - mozversion == 1.4 10:28:13 INFO - psutil == 3.1.1 10:28:13 INFO - requests == 1.2.3 10:28:13 INFO - wsgiref == 0.1.2 10:28:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:28:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:28:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:28:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:28:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:28:13 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 0x1a341f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bfca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d9fa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1da3090>, '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 0x1da3d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d9df90>, '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': 'df17445c3590ff7897617a0e00000225-1507570017.810534-660076180', '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 10:28:13 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 10:28:13 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 10:28:13 INFO - Using env: {'DISPLAY': ':0', 10:28:13 INFO - 'HOME': '/home/cltbld', 10:28:13 INFO - 'LANG': 'en_US.UTF-8', 10:28:13 INFO - 'LANGUAGE': 'en_US:en', 10:28:13 INFO - 'LOGNAME': 'cltbld', 10:28:13 INFO - 'MAIL': '/var/mail/cltbld', 10:28:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:28:13 INFO - 'MOZ_NO_REMOTE': '1', 10:28:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:28:13 INFO - 'NO_EM_RESTART': '1', 10:28:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:28:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:28:13 INFO - 'PWD': '/builds/slave/test', 10:28:13 INFO - 'SHELL': '/bin/bash', 10:28:13 INFO - 'SHLVL': '1', 10:28:13 INFO - 'TERM': 'linux', 10:28:13 INFO - 'TMOUT': '86400', 10:28:13 INFO - 'USER': 'cltbld', 10:28:13 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1507570017.810534-660076180', 10:28:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:28:13 INFO - '_': '/tools/buildbot/bin/python'} 10:28:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:28:13 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)) 10:28:13 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)) 10:28:13 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)) 10:28:13 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)) 10:28:13 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)) 10:28:13 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)) 10:28:13 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)) 10:28:13 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)) 10:28:13 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)) 10:28:13 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 10:28:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:28:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:28:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:28:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:28:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 10:28:14 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)) 10:28:14 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)) 10:28:14 INFO - Installing collected packages: simplejson 10:28:14 INFO - Running setup.py install for simplejson 10:28:14 INFO - building 'simplejson._speedups' extension 10:28:14 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 10:28:15 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 10:28:15 INFO - Successfully installed simplejson 10:28:15 INFO - Cleaning up... 10:28:15 INFO - Return code: 0 10:28:15 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:28:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:28:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:28:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:28:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:28:15 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 0x1a341f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bfca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d9fa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1da3090>, '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 0x1da3d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d9df90>, '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': 'df17445c3590ff7897617a0e00000225-1507570017.810534-660076180', '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 10:28:15 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 10:28:15 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 10:28:15 INFO - Using env: {'DISPLAY': ':0', 10:28:15 INFO - 'HOME': '/home/cltbld', 10:28:15 INFO - 'LANG': 'en_US.UTF-8', 10:28:15 INFO - 'LANGUAGE': 'en_US:en', 10:28:15 INFO - 'LOGNAME': 'cltbld', 10:28:15 INFO - 'MAIL': '/var/mail/cltbld', 10:28:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:28:15 INFO - 'MOZ_NO_REMOTE': '1', 10:28:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:28:15 INFO - 'NO_EM_RESTART': '1', 10:28:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:28:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:28:15 INFO - 'PWD': '/builds/slave/test', 10:28:15 INFO - 'SHELL': '/bin/bash', 10:28:15 INFO - 'SHLVL': '1', 10:28:15 INFO - 'TERM': 'linux', 10:28:15 INFO - 'TMOUT': '86400', 10:28:15 INFO - 'USER': 'cltbld', 10:28:15 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1507570017.810534-660076180', 10:28:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:28:15 INFO - '_': '/tools/buildbot/bin/python'} 10:28:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:28:16 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:28:16 INFO - Cleaning up... 10:28:16 INFO - Return code: 0 10:28:16 INFO - Running post-action listener: _resource_record_post_action 10:28:16 INFO - Running post-action listener: _start_resource_monitoring 10:28:16 INFO - Starting resource monitoring. 10:28:16 INFO - [mozharness: 2017-10-09 17:28:16.249533Z] Finished create-virtualenv step (success) 10:28:16 INFO - [mozharness: 2017-10-09 17:28:16.250527Z] Running install step. 10:28:16 INFO - Running pre-action listener: _resource_record_pre_action 10:28:16 INFO - Running main action method: install 10:28:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:28:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:28:16 INFO - Reading from file tmpfile_stdout 10:28:16 INFO - Detecting whether we're running mozinstall >=1.0... 10:28:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:28:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:28:16 INFO - Reading from file tmpfile_stdout 10:28:16 INFO - Output received: 10:28:16 INFO - Usage: mozinstall [options] installer 10:28:16 INFO - Options: 10:28:16 INFO - -h, --help show this help message and exit 10:28:16 INFO - -d DEST, --destination=DEST 10:28:16 INFO - Directory to install application into. [default: 10:28:16 INFO - "/builds/slave/test"] 10:28:16 INFO - --app=APP Application being installed. [default: firefox] 10:28:16 INFO - mkdir: /builds/slave/test/build/application 10:28:16 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'] 10:28:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 10:28:31 INFO - Reading from file tmpfile_stdout 10:28:31 INFO - Output received: 10:28:31 INFO - /builds/slave/test/build/application/firefox/firefox 10:28:31 INFO - Running post-action listener: _resource_record_post_action 10:28:31 INFO - [mozharness: 2017-10-09 17:28:31.192090Z] Finished install step (success) 10:28:31 INFO - [mozharness: 2017-10-09 17:28:31.192340Z] Running setup-mitmproxy step. 10:28:31 INFO - Running pre-action listener: _resource_record_pre_action 10:28:31 INFO - Running main action method: setup_mitmproxy 10:28:31 INFO - Skipping: mitmproxy is not required 10:28:31 INFO - Running post-action listener: _resource_record_post_action 10:28:31 INFO - [mozharness: 2017-10-09 17:28:31.193506Z] Finished setup-mitmproxy step (success) 10:28:31 INFO - [mozharness: 2017-10-09 17:28:31.193727Z] Running run-tests step. 10:28:31 INFO - Running pre-action listener: _resource_record_pre_action 10:28:31 INFO - Running pre-action listener: _set_gcov_prefix 10:28:31 INFO - Running main action method: run_tests 10:28:31 WARNING - Try message not found. 10:28:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:28:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:28:31 INFO - Python 2.7.3 10:28:31 INFO - Return code: 0 10:28:31 INFO - grabbing minidump binary from tooltool 10:28:31 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')]} 10:28:31 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--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 0x1da3090>, '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 0x1da3d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d9df90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:28:31 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--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 10:28:31 INFO - Copy/paste: /tools/tooltool.py --url https://tooltool.mozilla-releng.net/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 10:28:31 INFO - Calling ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--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 10:28:31 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:28:31 INFO - Return code: 0 10:28:31 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 10:28:31 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:28:31 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:28:31 INFO - ENV: RUST_BACKTRACE is now full 10:28:31 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 10:28:31 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:28:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/V7HEWaOjRfWkeHPKF2AjDg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-021', '--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 10:28:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/V7HEWaOjRfWkeHPKF2AjDg/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-021 --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 10:28:31 INFO - Using env: {'DISPLAY': ':0', 10:28:31 INFO - 'HOME': '/home/cltbld', 10:28:31 INFO - 'LANG': 'en_US.UTF-8', 10:28:31 INFO - 'LANGUAGE': 'en_US:en', 10:28:31 INFO - 'LOGNAME': 'cltbld', 10:28:31 INFO - 'MAIL': '/var/mail/cltbld', 10:28:31 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:28:31 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:28:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:28:31 INFO - 'MOZ_NO_REMOTE': '1', 10:28:31 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:28:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:28:31 INFO - 'NO_EM_RESTART': '1', 10:28:31 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:28:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:28:31 INFO - 'PWD': '/builds/slave/test', 10:28:31 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:28:31 INFO - 'RUST_BACKTRACE': 'full', 10:28:31 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 10:28:31 INFO - 'SHELL': '/bin/bash', 10:28:31 INFO - 'SHLVL': '1', 10:28:31 INFO - 'TERM': 'linux', 10:28:31 INFO - 'TMOUT': '86400', 10:28:31 INFO - 'USER': 'cltbld', 10:28:31 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1507570017.810534-660076180', 10:28:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:28:31 INFO - '_': '/tools/buildbot/bin/python'} 10:28:31 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/V7HEWaOjRfWkeHPKF2AjDg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-021', '--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 10:28:31 INFO - mozversion application_buildid: 20171009160756 10:28:31 INFO - mozversion application_changeset: b938d2eb9dc9503cc21ba58d3d3db53a45f93c30 10:28:31 INFO - mozversion application_display_name: Firefox 10:28:31 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:28:31 INFO - mozversion application_name: Firefox 10:28:31 INFO - mozversion application_remotingname: firefox 10:28:31 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 10:28:31 INFO - mozversion application_vendor: Mozilla 10:28:31 INFO - mozversion application_version: 57.0 10:28:31 INFO - mozversion platform_buildid: 20171009160756 10:28:31 INFO - mozversion platform_changeset: b938d2eb9dc9503cc21ba58d3d3db53a45f93c30 10:28:31 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 10:28:31 INFO - mozversion platform_version: 57.0 10:28:31 INFO - using testdate: 1507570111 10:28:31 INFO - actual date: 1507570111 10:28:31 INFO - starting webserver on 'localhost:32788' 10:28:31 INFO - SUITE-START | Running 2 tests 10:28:31 INFO - TEST-START | dromaeo_css 10:28:31 INFO - Initialising browser for dromaeo_css test... 10:28:31 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:32788/getInfo.html -profile /tmp/tmp8pawPW/profile 10:28:31 INFO - TEST-INFO | started process 3609 (/builds/slave/test/build/application/firefox/firefox http://localhost:32788/getInfo.html) 10:28:42 INFO - TEST-INFO | 3609: exit 0 10:28:42 INFO - Browser initialized. 10:28:42 INFO - Running cycle 1/1 for dromaeo_css test... 10:28:42 INFO - Using env: {'DISPLAY': ':0', 10:28:42 INFO - 'HOME': '/home/cltbld', 10:28:42 INFO - 'JSGC_DISABLE_POISONING': '1', 10:28:42 INFO - 'LANG': 'en_US.UTF-8', 10:28:42 INFO - 'LANGUAGE': 'en_US:en', 10:28:42 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 10:28:42 INFO - 'LOGNAME': 'cltbld', 10:28:42 INFO - 'MAIL': '/var/mail/cltbld', 10:28:42 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:28:42 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:28:42 INFO - 'MOZ_CRASHREPORTER': '1', 10:28:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:28:42 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 10:28:42 INFO - 'MOZ_NO_REMOTE': '1', 10:28:42 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:28:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:28:42 INFO - 'NO_EM_RESTART': '1', 10:28:42 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:28:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:28:42 INFO - 'PWD': '/builds/slave/test', 10:28:42 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:28:42 INFO - 'RUST_BACKTRACE': 'full', 10:28:42 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 10:28:42 INFO - 'SHELL': '/bin/bash', 10:28:42 INFO - 'SHLVL': '1', 10:28:42 INFO - 'TERM': 'linux', 10:28:42 INFO - 'TMOUT': '86400', 10:28:42 INFO - 'USER': 'cltbld', 10:28:42 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1507570017.810534-660076180', 10:28:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:28:42 INFO - '_': '/tools/buildbot/bin/python'} 10:28:42 INFO - TEST-INFO | started process 3844 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8pawPW/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 10:28:43 INFO - PID 3844 | 10:28:43 INFO - PID 3844 | (/builds/slave/test/build/application/firefox/firefox:3894): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 10:28:43 INFO - PID 3844 | 10:28:53 INFO - PID 3844 | RSS: Main: 141508608 10:28:53 INFO - PID 3844 | 10:31:50 INFO - PID 3844 | Cycle 1(1): loaded http://localhost:32788/tests/dromaeo/cssquery-dojo.html (next: http://localhost:32788/tests/dromaeo/cssquery-ext.html) 10:31:51 INFO - PID 3844 | RSS: Main: 145858560 10:31:51 INFO - PID 3844 | 10:34:53 INFO - PID 3844 | Cycle 1(1): loaded http://localhost:32788/tests/dromaeo/cssquery-ext.html (next: http://localhost:32788/tests/dromaeo/cssquery-jquery.html) 10:34:53 INFO - PID 3844 | RSS: Main: 144281600 10:34:53 INFO - PID 3844 | 10:37:55 INFO - PID 3844 | Cycle 1(1): loaded http://localhost:32788/tests/dromaeo/cssquery-jquery.html (next: http://localhost:32788/tests/dromaeo/cssquery-mootools.html) 10:37:55 INFO - PID 3844 | RSS: Main: 144961536 10:37:55 INFO - PID 3844 | 10:40:57 INFO - PID 3844 | Cycle 1(1): loaded http://localhost:32788/tests/dromaeo/cssquery-mootools.html (next: http://localhost:32788/tests/dromaeo/cssquery-prototype.html) 10:40:57 INFO - PID 3844 | RSS: Main: 142454784 10:40:57 INFO - PID 3844 | 10:44:00 INFO - PID 3844 | Cycle 1(1): loaded http://localhost:32788/tests/dromaeo/cssquery-prototype.html (next: http://localhost:32788/tests/dromaeo/cssquery-yui.html) 10:44:01 INFO - PID 3844 | RSS: Main: 145887232 10:44:01 INFO - PID 3844 | 10:47:02 INFO - PID 3844 | Cycle 1(1): loaded http://localhost:32788/tests/dromaeo/cssquery-yui.html (next: http://localhost:32788/tests/dromaeo/cssquery-dojo.html) 10:47:03 INFO - PID 3844 | RSS: Main: 148996096 10:47:03 INFO - PID 3844 | 10:47:03 INFO - PID 3844 | __start_tp_report 10:47:03 INFO - PID 3844 | _x_x_mozilla_page_load 10:47:03 INFO - PID 3844 | _x_x_mozilla_page_load_details 10:47:03 INFO - PID 3844 | |i|pagename|runs| 10:47:03 INFO - PID 3844 | |0;dojo.html;3998.460207871937;4015.8192881320338;4019.939700904487;4022.1352409232045;4039.676825853932;6346.619202847826;6391.903390007615;6393.0730044143575;6445.323241059691;6480.740770369185;6383.936160638392;6401.551891367606;6452.2257329120575;6465.74137034518;6498.935010649892;5672.68800215988;5748.367679555246;5780.450857168562;5784.45047720468;5794.652320860761;5771.22088518051;5798.768049278024;5802.100674395476;5815.5638327125425;5876.265466816648;5788.97105514474;5805.680687562182;5843.444872737083;5847.356790753014;5865.472107510323;5808.4191580842;5809;5854.795082172125;5891.7054147292465;5896.97051514744;5710.600257981943;5775.740091695884;5801.767929282823;5815.825525234208;5863.912041319383;6265.060240963846;6285.340039295854;6290.811275661737;6331.2719037310835;6360.55476116672;6850.588964662136;6924.861502769916;6935.306469353075;6946.166460024779;6980.476464265201;6842.281560436132;6856.52004359695;6875.862482750317;6947.305269473012;6969.686364113627;6416.390442907917;6486.805395838085;6492.285848556655;6506.089147519351;6521.282658907517;7019.087518622547;7095.574265544084;7115.822104447327;7136.357727804522;7195.604241766753;6750.493712971449;6751.662416879137;6756.76351327711;6778.593284402951;6865;6874.450043996469;6922;6922.826929326807;6936.653167341613;6974.79075627732;6805.387515123563;6822.658867056627;6877.209120951155;6907.481938854606;6924.6537673116145;6827.146606674166;6836.179658440919;6844.1444819397575;6919.930800691928;6936.410405115622;5025.296458495814;5063.468335824759;5094.235864620263;5103.157978933508;5117.181250999896;4614.054118905617;4639.211334073216;4639.979204574988;4655.348251244828;4734.763261836894;6426.559952571495;6519.152510173647;6594.175728033996;6595.934040659628;6610.669466526654;6794.320567943265;6855.5543889647015;6871.072405225331;6924.58452492852;6948.096747422904;6574.80275591733;6581.111549940792;6587.209534855752;6599.274079851212;6600.438962688226;5712.11462223356;5734.455226753452;5802.419758024248;5810.94189058104;5818.79634212809;6969.82575435608;7069.9646501767165;7075.150981882104;7104.786856394317;7194.244604316576;6596.637184954873;6617.536772425884;6685.598864068172;6717.429018533479;6897.068895699117;7180;7282.162551306667;7309.488335816654;7315.122185337794;7329.047223861077;6780.932190678227;6863.553868998499;6945.652717364011;6958.443324533924;6961.477889158435;6863.519553631398;6932.826679333057;6941.583504989717;6968.303169682991;6982.930170698228;6704.597724136567;6744.190697116377;6752.7844987902645;6767.86464270702;6775.186977562724;6636.13730215069;6655.301193374819;6719.697613607497;6723.899141512979;6730.427913627201;6603.504737144637;6612.8346791330605;6687.699053542505;6689.163854518185;6702.899456508254;6628.734850606114;6680.098186744727;6703.195616526048;6709.7316107355155;6792.626405547545;6291.842703932438;6472.935270647422;6574.671266436563;6637.435817955335;6640.83397915056 10:47:03 INFO - PID 3844 | |1;ext.html;971.7619183300093;977.3207620703612;1010.3887148275292;1037.6005237983375;1038.3977293169962;45857.54142458575;47008.294875576896;47110.05779884404;47221.52778472219;47235.763821180844;42809.14381712372;42961.35557966633;43002.56997430025;43026;43077.13845723092;7968.322692571124;8158.632861521216;8161.877571836427;8162.224588664097;8164.959175204116;7981.441299109065;8025.036995560541;8038.839223215532;8084.15116412777;8088.555129467877;8626.266767324785;8771.12288771124;8797.868031979526;8845.690400835972;8845.734627961172;8625.698100566482;8707.521086340248;8743;8749.343799215085;8776.736697899074;8660.48037117775;8661.956690216508;8680;8723.214910658007;8747.868781968276;41741.1651766966;41868.371974420406;41945.37081943773;42066;42175.36736948948;3714.572824125233;3728.272986767581;3736.4955730976244;3737.9252414951548;3752.3808571585655;32567.674323256702;33323.83338083318;33418.665813341795;33419.3316133676;33439.3312133756;5451.945480545183;5635.7463914123555;5661.150827375926;5685.260916080883;5693.373728889819;229374;230701;231713;231918;232105.9999999983;54847.45152548423;54891;54898.45101549013;54972.17541736877;55112.44887551153;56708;56758.14862777061;56874.14688779671;57012.42987570071;57025;18422.90788546049;18750.87494750292;18762.718559221623;18780.624387512446;18784.248630054644;15704.371825127095;15713.057216567042;15715.292811823496;15730.764038539432;15731;15658.921705391627;15952.361905523649;15989.520314390587;16100.516984490485;16149.19254037317;6131.240941576309;6160.10678451631;6180.907286390708;6243.562950593415;6351.395238452085;1106.9667909962714;1120.2830188679252;1127.2165844737829;1137.4881303413497;1137.7098839795965;26404.20787376382;26471.73528264731;26479;26594.86702566475;27095.458090838467;1261.2747670089734;1261.8548866880426;1262.1165184370977;1278.4310981613278;1283.813846992181;14108.012439129368;14203.502877399242;14250.786238206436;14424.711505769827;14466.493672721404;287829;295837;298249;299766;300012;63194;63435.68282158559;63570.36429635737;63604.36395636077;63910.36089639137;1547.102680445339;1560.5864445921613;1573.559403367059;1575.141547856421;1587.444394461929;30915.536266956464;31544.053678389686;31680.841595792797;32137;32549;43508;43790.56209437865;43793.78103109464;43816.78091609522;43879.34180987351;252719;252882;253934;254461;255500;38502.42246366363;39542.60457395389;40287;40291.395629065;40364.367206951516;47250.527494724614;48688.26967595418;48749.512504874496;48798;49159;36140.63859361373;36228.09429764277;36295.27409451849;36370.27259454849;36521;35504.46743298904;35641.46537801883;35874.641253588175;36060.639393606776;36220.637793621725;41578.79210603928;41937.58062419459;42091.36862946997;42246.57753422426;42360.364594531726;33864.3486606316;33973.66026339705;34468.65531344654;34542.30915381729;34688.479672804424;25810.483790323713;25918.22245332643;25947.740522594533;26054.609180861924;26157.346066348495 10:47:03 INFO - PID 3844 | |2;jquery.html;629.31719084793;630.8959021761412;652.2922628947591;653.9738410463582;665.40446300561;23855.64216536753;24147.39631509213;24892.87553562232;24952.999999999978;25168.496630067388;25826.35434114148;26705;26748.465030699375;26764.330891727717;26789.33026674334;6740.932590674104;6757.999999999987;6784.253732089466;6796.456283497333;6812.557183783063;6999.930000699978;7076.540024898391;7081.114860642419;7086.3976561992295;7087.362137407632;7015.2984701529695;7042.68307926142;7047.647617619098;7050.471214658921;7057;7002.929970700278;7007.684654190573;7043.718251269968;7044.647767611625;7055.823604409905;6523.673816309213;6569.770058047993;6586.670666466657;6596.43930265928;6621;29777;31894.840525797455;31981.200469988205;32040.519392209135;32166.839165804256;2306.261996161229;2309.7921187093075;2323.18688459038;2336.0538981712434;2337.31049340445;20299.898500507403;20885.68671469929;21374.503784735076;21481;21672.89163554188;2582.4060466092906;2641.656584644003;2643.8942442302287;2662.2412612405565;2665.866706664659;147261;152580;169096;176629;177043;16741.49775506737;17252.74120888188;17274.568135796704;17677.823221767874;17739.645207095786;27365.589516157273;27481.17556473309;27493.725062749116;27559.31101722473;27606.861965690045;11169;11237.83143252852;11271.380074096003;11274.774504509864;11629.360385178896;10263.384196948058;10297.227707921937;10302.484875756332;10360.222983276133;10378.377297362182;9954.800903982024;10084.49577521121;10240.846387304196;10292.588296468208;10383.792324153626;2920.8393538355595;2987.865546050433;2999.5200767877473;3012.502937015368;3024.0927721683406;1056.7358160459885;1071.7856428714288;1078.6494389323502;1088.4992903264429;1090.4547726136932;21827.67258491124;21832.126714931543;21842.932041445383;21985.560288794135;22130.778692212873;1141.0985321596013;1148.4200478758341;1153.5039932828963;1157.1379322404862;1157.3576664951033;11478.311301321948;11899.76200476003;11922.344271065002;11934.257144713209;11951.22317049389;667999;674210;682366;684288;690437;138916;140279;140704.29647851695;141449.29275353558;142198;1164.4352489042808;1226.760781647588;1273.331500961984;1276.4511260158222;1298.0848501806204;22358.552828943004;22657.660135097656;22855.885720571292;23032.193873214357;23046.76953230446;66321.33678663151;66931.33068669446;67957;68500.31499685139;70104.29895701182;82063;85905.57047214724;86092.56953715441;86274;86556;15907.761383579023;15992.120433376276;16091.517254482384;16152.11163386025;16282.755758663867;24118;24399.634005489577;24411.633825492987;24488.387790305384;24811.751882480945;19448;19926.202951882344;20074.498137546096;20117.79882201159;20263.696044559638;17604.823951760318;17788.733169002215;18004.279828806702;18038;18412.26350945947;20113.899430502755;20166.193352265745;20267.69598455995;20579.382618521468;20619.793802061788;15832.366705331659;15870.841291587398;15915.124668143364;15943.920280398524;15957;19250.326238581583;19407.708884366464;19629.70555441641;20051.197952081755;20068.498287542927 10:47:03 INFO - PID 3844 | |3;mootools.html;1396.8114304568883;1459.233902201344;1461.6126726417508;1469.9706005879882;1477.9334929928152;17574.82425175748;19005.61988760224;19079.904600477013;19105.42683719487;19130.043497825107;18484.2606295748;19017.52456188596;19030.809691903076;19039.52401189971;19047.333343332986;3073.6004319438553;3081.845907704617;3152.4956007038877;3152.858121384532;3168.9207769805826;3082.352705931757;3101.5192645139928;3146.8898588549405;3150.3226806236653;3151.5115157150562;3092.3815236952587;3159.0680749179046;3162.0355791483703;3198.344339410415;3200.9839950800215;3101.782875198737;3114.9688503114903;3138.0428969164395;3139.30935194258;3140.576022237003;2998.625171853518;2999.5650630658433;3016.4268788930035;3034.0442760530364;3035.8178509289514;17205.139743012798;17444.738328925076;17481.388151414638;17589.12054397275;17642.029688367136;8982.775430614221;9180.31147663928;9254.722358329262;9262.120098590623;9269.536523173814;5879.088741245071;5946.940530594682;6114.847128821771;6132.570720049598;6167.84580385494;2078.1064142418754;2080.136743251549;2098.916043358264;2107.283523601983;2151.956960860774;32671.346573068644;33024.17439564006;33100.66899331;33114.6688533114;33230.66769332324;7764.534127952228;7804.8829267559895;7824.139344672081;7881.093674227537;8054.23484768946;20761.37715868496;20784.896075519526;20803.271885483937;20824.47938801542;20883.37349879506;8946.329025322997;9098.727038188865;9099.272058235325;9107.271418286522;9112.22546083577;8306.169383061646;8312.709055183039;8350.791230219293;8373.120822313691;8379.455335403301;5866.442687944638;6034.9396506035255;6087.54343424245;6132.601380910227;6367.299597044322;1796.8652351073722;1812.9274829006956;1823.507652933727;1838.2555065198349;1845.8800177988387;874.1258741258741;1009.6163457885956;1022.754538910656;1031.834027548865;1056.10758908722;10021.849672254923;10194.337368071052;10253.641122560675;10275.486225688686;10300.124489418484;783.894174286464;819.6434550970347;836.2682652678906;843.5065486690355;914.3005600715458;6150.907736383869;6247.843803904939;6397.616143031433;6427.839304017437;6618.497109826628;25886.48227035449;27237.182884513495;27522.862385688342;27522.899084036813;27949.16152515428;26280.86859565728;27229.727702723114;27310;27364.45271094567;27545.311367215578;13042.478300867859;13148.276844773629;13378.732425351438;13404.5308414207;13406.32968351598;9451.149396554343;9559.856602150834;9574.03732234904;9603.087706667855;9758.512074396394;22279.10883564639;22288.665670014638;22499.550008999402;22864.77135228693;22880.855957202406;23259.767402326437;23398.298051058497;23907.641385378884;23934.28197154088;24032.63951040771;12577.93711031439;12731.2997785119;12799.360031998549;12821;12895.355232238539;16331.918340408221;16560.50318490447;16562.337506499603;16572.254248558602;16576.336946522006;12853.485860565472;12872.742545149233;12892;12947.805782913076;13030.478780849038;12576.811347829607;12746.936265318614;12966.286854223108;13102.410391532594;13195.076344655781;11315.151363647925;11400.714982125513;11409.714757131138;11484.253523520945;11541.826872597087;8493.702720404755;8532.274756645505;8654.22112009922;8721.302295816446;8740.694075707319;8441.70454034106;8450.535220562928;8560;8733.30133589324;8745.91254087451 10:47:03 INFO - PID 3844 | |4;prototype.html;574.6580784433261;585.979490717825;590.2120668907007;604.5586721693164;614.9938500614995;6277.968610156949;6295.905561416571;6298.811035668931;6333.493320534358;6359.936400635992;6173.166622505961;6176.197094377724;6189.769644650263;6206.813795586128;6291.874162516759;5199.532042116209;5219.791208351661;5222.477752224776;5226.973865130669;5230.869228269305;4920.3111564381015;5137.974310128444;5186.688798672073;5206.271122042917;5213.973930130344;5001.799928002875;5024.974875125619;5040.571551418134;5051.79792808289;5055.266986286986;5021.522955319276;5031;5072.492750724917;5080.41575218849;5091.472558232553;4533.6146427553695;4615.792289346954;4632.513586073447;4635.884102897421;4646.767661616939;6066.423689749511;6182.783602573888;6190.783322583688;6220.937790622126;6240.31356550779;5936.198613187251;5939.683523425867;5945.900008498442;5967.134765459027;5985.191999080112;6487.740490380379;6565.179352580927;6595.53831231814;6617.735290588371;6621.536492445531;5069.467705890902;5091.414487333967;5094.286799848024;5127.102757017545;5136.64043516954;6664.866702665968;6788.8302792430095;6878.621675807829;6917.654117294165;6974.686139123752;5230.97384513075;5246.685198888079;5256.342957130359;5272.314599102092;5293.417724050351;5327.786888524415;5337.306150200449;5377.677339359573;5397.70312632809;5398.298221231294;5871.3541510433815;5874.412558744091;5897.705114744332;5898.466398736359;5924.526037916957;6679.966600166968;6681.42986398196;6697.330266973264;6708.825955457775;6727.596344219264;1842.8802127861645;1845.4186931116656;1857.8792378495355;1866.56135808085;1877.9906100469411;1272.0840994483956;1307.3332600373878;1319.5381616434363;1331.7814200007078;1344.522694443478;6254.2807577129215;6269.780557680459;6303.149074874925;6320.62076275425;6331.493480521547;6597.373249541286;6603.438707709803;6721.655668866247;6820.590764554143;6849.842299675586;6369.17200763907;6380.585261957958;6398.840028999219;6400.967995159995;6411.455026322815;3536.45184996326;3538.3807833629526;3538.610752817188;3555.9418899746197;3556.78659280444;6984.825379365557;7068.646567671699;7071.92928070723;7076.787696369117;7081;6896.827579310558;6914.274001229899;6924.896126558106;6942.444604431735;6999.8600027999155;7033.366996970297;7059.25877782846;7086.362227399559;7091.184513780981;7121.82195445118;6686.3313668632745;6733.124693789776;6734.8653026940165;6763.7632682855865;6805.0472933788315;6718.899216511854;6733.69698363565;6763.2898545652;6787.253402125861;6792.558483698742;6990.965045174741;7052.82367940785;7079.646017698991;7088.255733147946;7092.5389849659605;5189.949969761999;5205.713685747321;5249.086756849985;5277.076511610376;5287.339082614673;6482.870342593216;6652.268250492539;6660.766873159416;6769.153855768029;6780.525363224527;6465.709043092978;6519.7392104315295;6608.4382827458285;6617.8014659560295;6635.933640663531;6453.645049522322;6547.279799221987;6577.177852768404;6578.736850525926;6626.801195964129;6301.590396624205;6386.584871983307;6505.934940650723;6570.507211959218;6579.276279609335;6529.706163222571;6565.441937435371;6571.704273307617;6572.244191917991;6625.801225963229;6360.268569114611;6387.329330420239;6421.5825971311715;6491.513136514686;6526.379993900572 10:47:03 INFO - PID 3844 | |5;yui.html;1009.8131845608563;1016.2073582605566;1035.3839465518017;1036.9896301036988;1040.2094408249732;18704.906475467622;19452.90273548632;19488.99999999998;21832.454188645293;22358.66462003067;22342.329730108122;22617.321480355615;22832.65751013732;23643.527129457445;23734.287971360885;1104.5913012185483;1135.2053562506237;1135.5401062569672;1135.585511288378;1137.772445510897;991.2317953585956;1094.529352378477;1104.6354702948008;1120.5741818109107;1121.327203677791;1170.1165619956962;1170.391396473833;1171.344047333496;1171.6485054483664;1174.6476057182854;1156.5200441816721;1157.5254145800225;1159.2928313728619;1166.1894982986828;1168.5559487394778;856.7558245899888;858.1204265627719;860.8106216632331;861.5649097205871;861.9655213791441;19936;20576.38270851877;20581.4854628634;20691.689624655643;20901.477463063395;24076.638850417083;24088.518229635483;24189.87905060481;24513.264602061965;24548.754512454827;19489.707654385194;19718.70421943672;19762.80237197624;19783.40649780509;19870.602587948306;3923.7253392262555;3965.5637879833193;3972.960270397288;3975.0062484378905;3976.324024915771;161661;165156;166223;166365.16817415957;168420;18676.43970680882;19000.904995474935;19005.14476848545;19009.76436531621;19052.237910483702;29371.41257174887;34985.65014349875;36078.458823117675;36088.63911360853;36115.458268126;9226.169644732006;10764.677059688222;10809.78380432387;10860.076893464144;10901.509432075576;4982.07831551157;5061.063703214917;5077.568406685399;5122.154844450699;5132.948670513321;6181.350958149419;6347.143135676717;6461.353864613595;6464.676766161673;6495;1210.8244304575787;1223.5534030079134;1247.8502579690496;1248.6441364211157;1251.0367017396736;635.5106567942751;666.2338310942358;674.6592970549841;680.43863812355;686.8111269400955;11567.942160289145;11679.474423650956;11808.202774174166;12550.372481376076;12727.427265773062;718.989215161773;721.5165838887958;723.5333210079469;734.8603765284579;742.3912391838641;5928.318243401977;5941;5941.762329506858;5979.222701048836;6020.946334391464;154805.2259738694;155253.22373388286;158268;158494;160104;137961;143554.28222858818;143666;144334;146230;123317;123747.38126309491;124607;125172;126754;10887.292325998786;10890.891091089305;10984.505697243483;11099.223054386115;11340.036096931854;59362.70318648379;59391.40608594032;59515;59826.401735983825;60624;74672.25327746653;77307;78253;78303;78870;14355.425782968565;14828.925855371086;14890.702185956437;15179.013364131297;16215.35138594443;19235;19653.11560979788;19779.901100494404;19838.702419464007;19843.40469785909;17794.46616601504;17802.287908483515;17870.374536891148;18024.819751802315;18118.5470363242;17531.21109550048;17715.114244287994;17823.376181833573;17894.821051789317;17897.642047159243;17397.30410783605;17475.82524174742;17524.123793810515;17622.030788306765;17712.114394280492;14236.572902812932;14276.643083922985;14346.426142954166;14371;14438;12865.549705760253;13006.609801705965;13219.603411897659;13227.933860330637;13404.061715679809 10:47:03 INFO - PID 3844 | __end_tp_report 10:47:03 INFO - PID 3844 | __start_cc_report 10:47:03 INFO - PID 3844 | _x_x_mozilla_cycle_collect,250 10:47:03 INFO - PID 3844 | __end_cc_report 10:47:03 INFO - PID 3844 | __startTimestamp1507571223072__endTimestamp 10:47:03 INFO - PID 3844 | 10:47:03 INFO - PID 3844 | ------- Summary: start ------- 10:47:03 INFO - PID 3844 | Number of tests: 6 10:47:03 INFO - PID 3844 | 10:47:03 INFO - PID 3844 | [#0] dojo.html Cycles:165 Average:6389.65 Median:6628.73 stddev:722.92 (10.9%) stddev-sans-first:700.38 10:47:03 INFO - PID 3844 | Values: 3998.5 4015.8 4019.9 4022.1 4039.7 6346.6 6391.9 6393.1 6445.3 6480.7 6383.9 6401.6 6452.2 6465.7 6498.9 5672.7 5748.4 5780.5 5784.5 5794.7 5771.2 5798.8 5802.1 5815.6 5876.3 5789.0 5805.7 5843.4 5847.4 5865.5 5808.4 5809.0 5854.8 5891.7 5897.0 5710.6 5775.7 5801.8 5815.8 5863.9 6265.1 6285.3 6290.8 6331.3 6360.6 6850.6 6924.9 6935.3 6946.2 6980.5 6842.3 6856.5 6875.9 6947.3 6969.7 6416.4 6486.8 6492.3 6506.1 6521.3 7019.1 7095.6 7115.8 7136.4 7195.6 6750.5 6751.7 6756.8 6778.6 6865.0 6874.5 6922.0 6922.8 6936.7 6974.8 6805.4 6822.7 6877.2 6907.5 6924.7 6827.1 6836.2 6844.1 6919.9 6936.4 5025.3 5063.5 5094.2 5103.2 5117.2 4614.1 4639.2 4640.0 4655.3 4734.8 6426.6 6519.2 6594.2 6595.9 6610.7 6794.3 6855.6 6871.1 6924.6 6948.1 6574.8 6581.1 6587.2 6599.3 6600.4 5712.1 5734.5 5802.4 5810.9 5818.8 6969.8 7070.0 7075.2 7104.8 7194.2 6596.6 6617.5 6685.6 6717.4 6897.1 7180.0 7282.2 7309.5 7315.1 7329.0 6780.9 6863.6 6945.7 6958.4 6961.5 6863.5 6932.8 6941.6 6968.3 6982.9 6704.6 6744.2 6752.8 6767.9 6775.2 6636.1 6655.3 6719.7 6723.9 6730.4 6603.5 6612.8 6687.7 6689.2 6702.9 6628.7 6680.1 6703.2 6709.7 6792.6 6291.8 6472.9 6574.7 6637.4 6640.8 10:47:03 INFO - PID 3844 | 10:47:03 INFO - PID 3844 | [#1] ext.html Cycles:180 Average:44843.32 Median:3737.21 stddev:68064.03 (1821.3%) stddev-sans-first:68175.26 10:47:03 INFO - PID 3844 | Values: 971.8 977.3 1010.4 1037.6 1038.4 45857.5 47008.3 47110.1 47221.5 47235.8 42809.1 42961.4 43002.6 43026.0 43077.1 7968.3 8158.6 8161.9 8162.2 8165.0 7981.4 8025.0 8038.8 8084.2 8088.6 8626.3 8771.1 8797.9 8845.7 8845.7 8625.7 8707.5 8743.0 8749.3 8776.7 8660.5 8662.0 8680.0 8723.2 8747.9 41741.2 41868.4 41945.4 42066.0 42175.4 3714.6 3728.3 3736.5 3737.9 3752.4 32567.7 33323.8 33418.7 33419.3 33439.3 5451.9 5635.7 5661.2 5685.3 5693.4 229374.0 230701.0 231713.0 231918.0 232106.0 54847.5 54891.0 54898.5 54972.2 55112.4 56708.0 56758.1 56874.1 57012.4 57025.0 18422.9 18750.9 18762.7 18780.6 18784.2 15704.4 15713.1 15715.3 15730.8 15731.0 15658.9 15952.4 15989.5 16100.5 16149.2 6131.2 6160.1 6180.9 6243.6 6351.4 1107.0 1120.3 1127.2 1137.5 1137.7 26404.2 26471.7 26479.0 26594.9 27095.5 1261.3 1261.9 1262.1 1278.4 1283.8 14108.0 14203.5 14250.8 14424.7 14466.5 287829.0 295837.0 298249.0 299766.0 300012.0 63194.0 63435.7 63570.4 63604.4 63910.4 1547.1 1560.6 1573.6 1575.1 1587.4 30915.5 31544.1 31680.8 32137.0 32549.0 43508.0 43790.6 43793.8 43816.8 43879.3 252719.0 252882.0 253934.0 254461.0 255500.0 38502.4 39542.6 40287.0 40291.4 40364.4 47250.5 48688.3 48749.5 48798.0 49159.0 36140.6 36228.1 36295.3 36370.3 36521.0 35504.5 35641.5 35874.6 36060.6 36220.6 41578.8 41937.6 42091.4 42246.6 42360.4 33864.3 33973.7 34468.7 34542.3 34688.5 25810.5 25918.2 25947.7 26054.6 26157.3 10:47:03 INFO - PID 3844 | 10:47:03 INFO - PID 3844 | [#2] jquery.html Cycles:180 Average:43236.34 Median:22756.77 stddev:113612.16 (499.2%) stddev-sans-first:113885.83 10:47:03 INFO - PID 3844 | Values: 629.3 630.9 652.3 654.0 665.4 23855.6 24147.4 24892.9 24953.0 25168.5 25826.4 26705.0 26748.5 26764.3 26789.3 6740.9 6758.0 6784.3 6796.5 6812.6 6999.9 7076.5 7081.1 7086.4 7087.4 7015.3 7042.7 7047.6 7050.5 7057.0 7002.9 7007.7 7043.7 7044.6 7055.8 6523.7 6569.8 6586.7 6596.4 6621.0 29777.0 31894.8 31981.2 32040.5 32166.8 2306.3 2309.8 2323.2 2336.1 2337.3 20299.9 20885.7 21374.5 21481.0 21672.9 2582.4 2641.7 2643.9 2662.2 2665.9 147261.0 152580.0 169096.0 176629.0 177043.0 16741.5 17252.7 17274.6 17677.8 17739.6 27365.6 27481.2 27493.7 27559.3 27606.9 11169.0 11237.8 11271.4 11274.8 11629.4 10263.4 10297.2 10302.5 10360.2 10378.4 9954.8 10084.5 10240.8 10292.6 10383.8 2920.8 2987.9 2999.5 3012.5 3024.1 1056.7 1071.8 1078.6 1088.5 1090.5 21827.7 21832.1 21842.9 21985.6 22130.8 1141.1 1148.4 1153.5 1157.1 1157.4 11478.3 11899.8 11922.3 11934.3 11951.2 667999.0 674210.0 682366.0 684288.0 690437.0 138916.0 140279.0 140704.3 141449.3 142198.0 1164.4 1226.8 1273.3 1276.5 1298.1 22358.6 22657.7 22855.9 23032.2 23046.8 66321.3 66931.3 67957.0 68500.3 70104.3 82063.0 85905.6 86092.6 86274.0 86556.0 15907.8 15992.1 16091.5 16152.1 16282.8 24118.0 24399.6 24411.6 24488.4 24811.8 19448.0 19926.2 20074.5 20117.8 20263.7 17604.8 17788.7 18004.3 18038.0 18412.3 20113.9 20166.2 20267.7 20579.4 20619.8 15832.4 15870.8 15915.1 15943.9 15957.0 19250.3 19407.7 19629.7 20051.2 20068.5 10:47:03 INFO - PID 3844 | 10:47:03 INFO - PID 3844 | [#3] mootools.html Cycles:180 Average:11173.91 Median:27522.88 stddev:8338.87 (30.3%) stddev-sans-first:8329.91 10:47:03 INFO - PID 3844 | Values: 1396.8 1459.2 1461.6 1470.0 1477.9 17574.8 19005.6 19079.9 19105.4 19130.0 18484.3 19017.5 19030.8 19039.5 19047.3 3073.6 3081.8 3152.5 3152.9 3168.9 3082.4 3101.5 3146.9 3150.3 3151.5 3092.4 3159.1 3162.0 3198.3 3201.0 3101.8 3115.0 3138.0 3139.3 3140.6 2998.6 2999.6 3016.4 3034.0 3035.8 17205.1 17444.7 17481.4 17589.1 17642.0 8982.8 9180.3 9254.7 9262.1 9269.5 5879.1 5946.9 6114.8 6132.6 6167.8 2078.1 2080.1 2098.9 2107.3 2152.0 32671.3 33024.2 33100.7 33114.7 33230.7 7764.5 7804.9 7824.1 7881.1 8054.2 20761.4 20784.9 20803.3 20824.5 20883.4 8946.3 9098.7 9099.3 9107.3 9112.2 8306.2 8312.7 8350.8 8373.1 8379.5 5866.4 6034.9 6087.5 6132.6 6367.3 1796.9 1812.9 1823.5 1838.3 1845.9 874.1 1009.6 1022.8 1031.8 1056.1 10021.8 10194.3 10253.6 10275.5 10300.1 783.9 819.6 836.3 843.5 914.3 6150.9 6247.8 6397.6 6427.8 6618.5 25886.5 27237.2 27522.9 27522.9 27949.2 26280.9 27229.7 27310.0 27364.5 27545.3 13042.5 13148.3 13378.7 13404.5 13406.3 9451.1 9559.9 9574.0 9603.1 9758.5 22279.1 22288.7 22499.6 22864.8 22880.9 23259.8 23398.3 23907.6 23934.3 24032.6 12577.9 12731.3 12799.4 12821.0 12895.4 16331.9 16560.5 16562.3 16572.3 16576.3 12853.5 12872.7 12892.0 12947.8 13030.5 12576.8 12746.9 12966.3 13102.4 13195.1 11315.2 11400.7 11409.7 11484.3 11541.8 8493.7 8532.3 8654.2 8721.3 8740.7 8441.7 8450.5 8560.0 8733.3 8745.9 10:47:03 INFO - PID 3844 | 10:47:03 INFO - PID 3844 | [#4] prototype.html Cycles:180 Average:5675.92 Median:6302.37 stddev:1566.12 (24.8%) stddev-sans-first:1522.99 10:47:03 INFO - PID 3844 | Values: 574.7 586.0 590.2 604.6 615.0 6278.0 6295.9 6298.8 6333.5 6359.9 6173.2 6176.2 6189.8 6206.8 6291.9 5199.5 5219.8 5222.5 5227.0 5230.9 4920.3 5138.0 5186.7 5206.3 5214.0 5001.8 5025.0 5040.6 5051.8 5055.3 5021.5 5031.0 5072.5 5080.4 5091.5 4533.6 4615.8 4632.5 4635.9 4646.8 6066.4 6182.8 6190.8 6220.9 6240.3 5936.2 5939.7 5945.9 5967.1 5985.2 6487.7 6565.2 6595.5 6617.7 6621.5 5069.5 5091.4 5094.3 5127.1 5136.6 6664.9 6788.8 6878.6 6917.7 6974.7 5231.0 5246.7 5256.3 5272.3 5293.4 5327.8 5337.3 5377.7 5397.7 5398.3 5871.4 5874.4 5897.7 5898.5 5924.5 6680.0 6681.4 6697.3 6708.8 6727.6 1842.9 1845.4 1857.9 1866.6 1878.0 1272.1 1307.3 1319.5 1331.8 1344.5 6254.3 6269.8 6303.1 6320.6 6331.5 6597.4 6603.4 6721.7 6820.6 6849.8 6369.2 6380.6 6398.8 6401.0 6411.5 3536.5 3538.4 3538.6 3555.9 3556.8 6984.8 7068.6 7071.9 7076.8 7081.0 6896.8 6914.3 6924.9 6942.4 6999.9 7033.4 7059.3 7086.4 7091.2 7121.8 6686.3 6733.1 6734.9 6763.8 6805.0 6718.9 6733.7 6763.3 6787.3 6792.6 6991.0 7052.8 7079.6 7088.3 7092.5 5189.9 5205.7 5249.1 5277.1 5287.3 6482.9 6652.3 6660.8 6769.2 6780.5 6465.7 6519.7 6608.4 6617.8 6635.9 6453.6 6547.3 6577.2 6578.7 6626.8 6301.6 6386.6 6505.9 6570.5 6579.3 6529.7 6565.4 6571.7 6572.2 6625.8 6360.3 6387.3 6421.6 6491.5 6526.4 10:47:03 INFO - PID 3844 | 10:47:03 INFO - PID 3844 | [#5] yui.html Cycles:180 Average:29695.30 Median:17961.23 stddev:44979.04 (250.4%) stddev-sans-first:45053.65 10:47:03 INFO - PID 3844 | Values: 1009.8 1016.2 1035.4 1037.0 1040.2 18704.9 19452.9 19489.0 21832.5 22358.7 22342.3 22617.3 22832.7 23643.5 23734.3 1104.6 1135.2 1135.5 1135.6 1137.8 991.2 1094.5 1104.6 1120.6 1121.3 1170.1 1170.4 1171.3 1171.6 1174.6 1156.5 1157.5 1159.3 1166.2 1168.6 856.8 858.1 860.8 861.6 862.0 19936.0 20576.4 20581.5 20691.7 20901.5 24076.6 24088.5 24189.9 24513.3 24548.8 19489.7 19718.7 19762.8 19783.4 19870.6 3923.7 3965.6 3973.0 3975.0 3976.3 161661.0 165156.0 166223.0 166365.2 168420.0 18676.4 19000.9 19005.1 19009.8 19052.2 29371.4 34985.7 36078.5 36088.6 36115.5 9226.2 10764.7 10809.8 10860.1 10901.5 4982.1 5061.1 5077.6 5122.2 5132.9 6181.4 6347.1 6461.4 6464.7 6495.0 1210.8 1223.6 1247.9 1248.6 1251.0 635.5 666.2 674.7 680.4 686.8 11567.9 11679.5 11808.2 12550.4 12727.4 719.0 721.5 723.5 734.9 742.4 5928.3 5941.0 5941.8 5979.2 6020.9 154805.2 155253.2 158268.0 158494.0 160104.0 137961.0 143554.3 143666.0 144334.0 146230.0 123317.0 123747.4 124607.0 125172.0 126754.0 10887.3 10890.9 10984.5 11099.2 11340.0 59362.7 59391.4 59515.0 59826.4 60624.0 74672.3 77307.0 78253.0 78303.0 78870.0 14355.4 14828.9 14890.7 15179.0 16215.4 19235.0 19653.1 19779.9 19838.7 19843.4 17794.5 17802.3 17870.4 18024.8 18118.5 17531.2 17715.1 17823.4 17894.8 17897.6 17397.3 17475.8 17524.1 17622.0 17712.1 14236.6 14276.6 14346.4 14371.0 14438.0 12865.5 13006.6 13219.6 13227.9 13404.1 10:47:03 INFO - PID 3844 | -------- Summary: end -------- 10:47:03 INFO - PID 3844 | 10:47:03 INFO - TEST-INFO | 3844: exit 0 10:47:03 INFO - TEST-OK | dromaeo_css | took 1112082ms 10:47:03 INFO - TEST-START | kraken 10:47:03 INFO - Initialising browser for kraken test... 10:47:03 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:32788/getInfo.html -profile /tmp/tmpv8pyAn/profile 10:47:03 INFO - TEST-INFO | started process 4233 (/builds/slave/test/build/application/firefox/firefox http://localhost:32788/getInfo.html) 10:47:09 INFO - TEST-INFO | 4233: exit 0 10:47:09 INFO - Browser initialized. 10:47:09 INFO - Running cycle 1/1 for kraken test... 10:47:09 INFO - Using env: {'DISPLAY': ':0', 10:47:09 INFO - 'HOME': '/home/cltbld', 10:47:09 INFO - 'JSGC_DISABLE_POISONING': '1', 10:47:09 INFO - 'LANG': 'en_US.UTF-8', 10:47:09 INFO - 'LANGUAGE': 'en_US:en', 10:47:09 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 10:47:09 INFO - 'LOGNAME': 'cltbld', 10:47:09 INFO - 'MAIL': '/var/mail/cltbld', 10:47:09 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:47:09 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:47:09 INFO - 'MOZ_CRASHREPORTER': '1', 10:47:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:47:09 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 10:47:09 INFO - 'MOZ_NO_REMOTE': '1', 10:47:09 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:47:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:47:09 INFO - 'NO_EM_RESTART': '1', 10:47:09 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:47:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:47:09 INFO - 'PWD': '/builds/slave/test', 10:47:09 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:47:09 INFO - 'RUST_BACKTRACE': 'full', 10:47:09 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 10:47:09 INFO - 'SHELL': '/bin/bash', 10:47:09 INFO - 'SHLVL': '1', 10:47:09 INFO - 'TERM': 'linux', 10:47:09 INFO - 'TMOUT': '86400', 10:47:09 INFO - 'USER': 'cltbld', 10:47:09 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1507570017.810534-660076180', 10:47:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:47:09 INFO - '_': '/tools/buildbot/bin/python'} 10:47:09 INFO - TEST-INFO | started process 4471 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpv8pyAn/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 10:47:10 INFO - PID 4471 | 10:47:10 INFO - PID 4471 | (/builds/slave/test/build/application/firefox/firefox:4520): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 10:47:10 INFO - PID 4471 | 10:47:20 INFO - PID 4471 | RSS: Main: 142041088 10:47:20 INFO - PID 4471 | 10:47:23 INFO - PID 4471 | Cycle 1(1): loaded http://localhost:32788/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:32788/tests/kraken/driver.html?testName=audio-beat-detection) 10:47:24 INFO - PID 4471 | RSS: Main: 148013056 10:47:24 INFO - PID 4471 | 10:47:26 INFO - PID 4471 | Cycle 1(1): loaded http://localhost:32788/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:32788/tests/kraken/driver.html?testName=audio-dft) 10:47:27 INFO - PID 4471 | RSS: Main: 148185088 10:47:27 INFO - PID 4471 | 10:47:30 INFO - PID 4471 | Cycle 1(1): loaded http://localhost:32788/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:32788/tests/kraken/driver.html?testName=audio-fft) 10:47:30 INFO - PID 4471 | RSS: Main: 149811200 10:47:30 INFO - PID 4471 | 10:47:32 INFO - PID 4471 | Cycle 1(1): loaded http://localhost:32788/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:32788/tests/kraken/driver.html?testName=audio-oscillator) 10:47:33 INFO - PID 4471 | RSS: Main: 149549056 10:47:33 INFO - PID 4471 | 10:47:35 INFO - PID 4471 | Cycle 1(1): loaded http://localhost:32788/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:32788/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:47:35 INFO - PID 4471 | RSS: Main: 149286912 10:47:35 INFO - PID 4471 | 10:47:39 INFO - PID 4471 | Cycle 1(1): loaded http://localhost:32788/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:32788/tests/kraken/driver.html?testName=imaging-darkroom) 10:47:39 INFO - PID 4471 | RSS: Main: 149270528 10:47:39 INFO - PID 4471 | 10:47:43 INFO - PID 4471 | Cycle 1(1): loaded http://localhost:32788/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:32788/tests/kraken/driver.html?testName=imaging-desaturate) 10:47:43 INFO - PID 4471 | RSS: Main: 149999616 10:47:43 INFO - PID 4471 | 10:47:46 INFO - PID 4471 | Cycle 1(1): loaded http://localhost:32788/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:32788/tests/kraken/driver.html?testName=json-parse-financial) 10:47:47 INFO - PID 4471 | RSS: Main: 151838720 10:47:47 INFO - PID 4471 | 10:47:48 INFO - PID 4471 | Cycle 1(1): loaded http://localhost:32788/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:32788/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:47:49 INFO - PID 4471 | RSS: Main: 151818240 10:47:49 INFO - PID 4471 | 10:47:50 INFO - PID 4471 | Cycle 1(1): loaded http://localhost:32788/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:32788/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:47:51 INFO - PID 4471 | RSS: Main: 152109056 10:47:51 INFO - PID 4471 | 10:47:53 INFO - PID 4471 | Cycle 1(1): loaded http://localhost:32788/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:32788/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:47:54 INFO - PID 4471 | RSS: Main: 148791296 10:47:54 INFO - PID 4471 | 10:47:56 INFO - PID 4471 | Cycle 1(1): loaded http://localhost:32788/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:32788/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:47:57 INFO - PID 4471 | RSS: Main: 148578304 10:47:57 INFO - PID 4471 | 10:47:59 INFO - PID 4471 | Cycle 1(1): loaded http://localhost:32788/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:32788/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:48:00 INFO - PID 4471 | RSS: Main: 149037056 10:48:00 INFO - PID 4471 | 10:48:02 INFO - PID 4471 | Cycle 1(1): loaded http://localhost:32788/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:32788/tests/kraken/driver.html?testName=ai-astar) 10:48:02 INFO - PID 4471 | RSS: Main: 150515712 10:48:02 INFO - PID 4471 | 10:48:02 INFO - PID 4471 | __start_tp_report 10:48:02 INFO - PID 4471 | _x_x_mozilla_page_load 10:48:02 INFO - PID 4471 | _x_x_mozilla_page_load_details 10:48:02 INFO - PID 4471 | |i|pagename|runs| 10:48:02 INFO - PID 4471 | |0;ai-astar;107;103;105;106;106;107;106;106;104;106 10:48:02 INFO - PID 4471 | |1;audio-beat-detection;110;115;113;111;110;111;140;112;111;142 10:48:02 INFO - PID 4471 | |2;audio-dft;162;162;164;161;162;161;163;161;162;162 10:48:02 INFO - PID 4471 | |3;audio-fft;73;74;72;73;74;74;73;74;73;72 10:48:02 INFO - PID 4471 | |4;audio-oscillator;77;77;76;77;76;77;76;77;76;77 10:48:02 INFO - PID 4471 | |5;imaging-gaussian-blur;113;114;114;110;114;114;114;111;114;116 10:48:02 INFO - PID 4471 | |6;imaging-darkroom;151;147;148;148;149;149;148;148;150;149 10:48:02 INFO - PID 4471 | |7;imaging-desaturate;94;99;95;94;94;94;94;95;94;99 10:48:02 INFO - PID 4471 | |8;json-parse-financial;45;42;42;43;44;49;44;45;45;44 10:48:02 INFO - PID 4471 | |9;json-stringify-tinderbox;39;39;38;38;38;39;40;38;39;39 10:48:02 INFO - PID 4471 | |10;stanford-crypto-aes;70;72;68;69;70;68;69;70;68;71 10:48:02 INFO - PID 4471 | |11;stanford-crypto-ccm;103;103;113;101;103;107;105;102;106;103 10:48:02 INFO - PID 4471 | |12;stanford-crypto-pbkdf2;154;146;150;146;142;147;143;151;145;157 10:48:02 INFO - PID 4471 | |13;stanford-crypto-sha256-iterative;58;60;59;59;57;57;57;57;55;61 10:48:02 INFO - PID 4471 | __end_tp_report 10:48:02 INFO - PID 4471 | __start_cc_report 10:48:02 INFO - PID 4471 | _x_x_mozilla_cycle_collect,709 10:48:02 INFO - PID 4471 | __end_cc_report 10:48:02 INFO - PID 4471 | __startTimestamp1507571282363__endTimestamp 10:48:02 INFO - PID 4471 | 10:48:02 INFO - PID 4471 | ------- Summary: start ------- 10:48:02 INFO - PID 4471 | Number of tests: 14 10:48:02 INFO - PID 4471 | 10:48:02 INFO - PID 4471 | [#0] ai-astar Cycles:10 Average:105.60 Median:106.00 stddev:1.26 (1.2%) stddev-sans-first:1.24 10:48:02 INFO - PID 4471 | Values: 107.0 103.0 105.0 106.0 106.0 107.0 106.0 106.0 104.0 106.0 10:48:02 INFO - PID 4471 | 10:48:02 INFO - PID 4471 | [#1] audio-beat-detection Cycles:10 Average:117.50 Median:112.50 stddev:12.48 (11.1%) stddev-sans-first:12.94 10:48:02 INFO - PID 4471 | Values: 110.0 115.0 113.0 111.0 110.0 111.0 140.0 112.0 111.0 142.0 10:48:02 INFO - PID 4471 | 10:48:02 INFO - PID 4471 | [#2] audio-dft Cycles:10 Average:162.00 Median:162.00 stddev:0.94 (0.6%) stddev-sans-first:1.00 10:48:02 INFO - PID 4471 | Values: 162.0 162.0 164.0 161.0 162.0 161.0 163.0 161.0 162.0 162.0 10:48:02 INFO - PID 4471 | 10:48:02 INFO - PID 4471 | [#3] audio-fft Cycles:10 Average:73.20 Median:73.50 stddev:0.79 (1.1%) stddev-sans-first:0.83 10:48:02 INFO - PID 4471 | Values: 73.0 74.0 72.0 73.0 74.0 74.0 73.0 74.0 73.0 72.0 10:48:02 INFO - PID 4471 | 10:48:02 INFO - PID 4471 | [#4] audio-oscillator Cycles:10 Average:76.60 Median:77.00 stddev:0.52 (0.7%) stddev-sans-first:0.53 10:48:02 INFO - PID 4471 | Values: 77.0 77.0 76.0 77.0 76.0 77.0 76.0 77.0 76.0 77.0 10:48:02 INFO - PID 4471 | 10:48:02 INFO - PID 4471 | [#5] imaging-gaussian-blur Cycles:10 Average:113.40 Median:114.00 stddev:1.71 (1.5%) stddev-sans-first:1.81 10:48:02 INFO - PID 4471 | Values: 113.0 114.0 114.0 110.0 114.0 114.0 114.0 111.0 114.0 116.0 10:48:02 INFO - PID 4471 | 10:48:02 INFO - PID 4471 | [#6] imaging-darkroom Cycles:10 Average:148.70 Median:149.00 stddev:1.16 (0.8%) stddev-sans-first:0.88 10:48:02 INFO - PID 4471 | Values: 151.0 147.0 148.0 148.0 149.0 149.0 148.0 148.0 150.0 149.0 10:48:02 INFO - PID 4471 | 10:48:02 INFO - PID 4471 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:94.50 stddev:2.04 (2.2%) stddev-sans-first:2.12 10:48:02 INFO - PID 4471 | Values: 94.0 99.0 95.0 94.0 94.0 94.0 94.0 95.0 94.0 99.0 10:48:02 INFO - PID 4471 | 10:48:02 INFO - PID 4471 | [#8] json-parse-financial Cycles:10 Average:44.30 Median:44.50 stddev:2.00 (4.5%) stddev-sans-first:2.11 10:48:02 INFO - PID 4471 | Values: 45.0 42.0 42.0 43.0 44.0 49.0 44.0 45.0 45.0 44.0 10:48:02 INFO - PID 4471 | 10:48:02 INFO - PID 4471 | [#9] json-stringify-tinderbox Cycles:10 Average:38.70 Median:39.00 stddev:0.67 (1.7%) stddev-sans-first:0.71 10:48:02 INFO - PID 4471 | Values: 39.0 39.0 38.0 38.0 38.0 39.0 40.0 38.0 39.0 39.0 10:48:02 INFO - PID 4471 | 10:48:02 INFO - PID 4471 | [#10] stanford-crypto-aes Cycles:10 Average:69.50 Median:70.00 stddev:1.35 (1.9%) stddev-sans-first:1.42 10:48:02 INFO - PID 4471 | Values: 70.0 72.0 68.0 69.0 70.0 68.0 69.0 70.0 68.0 71.0 10:48:02 INFO - PID 4471 | 10:48:02 INFO - PID 4471 | [#11] stanford-crypto-ccm Cycles:10 Average:104.60 Median:104.00 stddev:3.47 (3.3%) stddev-sans-first:3.63 10:48:02 INFO - PID 4471 | Values: 103.0 103.0 113.0 101.0 103.0 107.0 105.0 102.0 106.0 103.0 10:48:02 INFO - PID 4471 | 10:48:02 INFO - PID 4471 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:148.10 Median:148.50 stddev:4.82 (3.2%) stddev-sans-first:4.61 10:48:02 INFO - PID 4471 | Values: 154.0 146.0 150.0 146.0 142.0 147.0 143.0 151.0 145.0 157.0 10:48:02 INFO - PID 4471 | 10:48:02 INFO - PID 4471 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:58.00 Median:58.50 stddev:1.76 (3.0%) stddev-sans-first:1.87 10:48:02 INFO - PID 4471 | Values: 58.0 60.0 59.0 59.0 57.0 57.0 57.0 57.0 55.0 61.0 10:48:02 INFO - PID 4471 | -------- Summary: end -------- 10:48:02 INFO - PID 4471 | 10:48:02 INFO - PID 4471 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 10:48:03 INFO - TEST-INFO | 4471: exit 0 10:48:03 INFO - TEST-OK | kraken | took 59216ms 10:48:03 INFO - SUITE-END | took 1171s 10:48:03 INFO - Completed test suite (00:19:31) 10:48:03 INFO - javascript benchmark 10:48:03 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 9391.378676482473, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3998.460207871937, 4015.8192881320338, 4019.939700904487, 4022.1352409232045, 4039.676825853932, 6346.619202847826, 6391.903390007615, 6393.0730044143575, 6445.323241059691, 6480.740770369185, 6383.936160638392, 6401.551891367606, 6452.2257329120575, 6465.74137034518, 6498.935010649892, 5672.68800215988, 5748.367679555246, 5780.450857168562, 5784.45047720468, 5794.652320860761, 5771.22088518051, 5798.768049278024, 5802.100674395476, 5815.5638327125425, 5876.265466816648, 5788.97105514474, 5805.680687562182, 5843.444872737083, 5847.356790753014, 5865.472107510323, 5808.4191580842, 5809.0, 5854.795082172125, 5891.7054147292465, 5896.97051514744, 5710.600257981943, 5775.740091695884, 5801.767929282823, 5815.825525234208, 5863.912041319383, 6265.060240963846, 6285.340039295854, 6290.811275661737, 6331.2719037310835, 6360.55476116672, 6850.588964662136, 6924.861502769916, 6935.306469353075, 6946.166460024779, 6980.476464265201, 6842.281560436132, 6856.52004359695, 6875.862482750317, 6947.305269473012, 6969.686364113627, 6416.390442907917, 6486.805395838085, 6492.285848556655, 6506.089147519351, 6521.282658907517, 7019.087518622547, 7095.574265544084, 7115.822104447327, 7136.357727804522, 7195.604241766753, 6750.493712971449, 6751.662416879137, 6756.76351327711, 6778.593284402951, 6865.0, 6874.450043996469, 6922.0, 6922.826929326807, 6936.653167341613, 6974.79075627732, 6805.387515123563, 6822.658867056627, 6877.209120951155, 6907.481938854606, 6924.6537673116145, 6827.146606674166, 6836.179658440919, 6844.1444819397575, 6919.930800691928, 6936.410405115622, 5025.296458495814, 5063.468335824759, 5094.235864620263, 5103.157978933508, 5117.181250999896, 4614.054118905617, 4639.211334073216, 4639.979204574988, 4655.348251244828, 4734.763261836894, 6426.559952571495, 6519.152510173647, 6594.175728033996, 6595.934040659628, 6610.669466526654, 6794.320567943265, 6855.5543889647015, 6871.072405225331, 6924.58452492852, 6948.096747422904, 6574.80275591733, 6581.111549940792, 6587.209534855752, 6599.274079851212, 6600.438962688226, 5712.11462223356, 5734.455226753452, 5802.419758024248, 5810.94189058104, 5818.79634212809, 6969.82575435608, 7069.9646501767165, 7075.150981882104, 7104.786856394317, 7194.244604316576, 6596.637184954873, 6617.536772425884, 6685.598864068172, 6717.429018533479, 6897.068895699117, 7180.0, 7282.162551306667, 7309.488335816654, 7315.122185337794, 7329.047223861077, 6780.932190678227, 6863.553868998499, 6945.652717364011, 6958.443324533924, 6961.477889158435, 6863.519553631398, 6932.826679333057, 6941.583504989717, 6968.303169682991, 6982.930170698228, 6704.597724136567, 6744.190697116377, 6752.7844987902645, 6767.86464270702, 6775.186977562724, 6636.13730215069, 6655.301193374819, 6719.697613607497, 6723.899141512979, 6730.427913627201, 6603.504737144637, 6612.8346791330605, 6687.699053542505, 6689.163854518185, 6702.899456508254, 6628.734850606114, 6680.098186744727, 6703.195616526048, 6709.7316107355155, 6792.626405547545, 6291.842703932438, 6472.935270647422, 6574.671266436563, 6637.435817955335, 6640.83397915056], "value": 6342.816996288171, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [971.7619183300093, 977.3207620703612, 1010.3887148275292, 1037.6005237983375, 1038.3977293169962, 45857.54142458575, 47008.294875576896, 47110.05779884404, 47221.52778472219, 47235.763821180844, 42809.14381712372, 42961.35557966633, 43002.56997430025, 43026.0, 43077.13845723092, 7968.322692571124, 8158.632861521216, 8161.877571836427, 8162.224588664097, 8164.959175204116, 7981.441299109065, 8025.036995560541, 8038.839223215532, 8084.15116412777, 8088.555129467877, 8626.266767324785, 8771.12288771124, 8797.868031979526, 8845.690400835972, 8845.734627961172, 8625.698100566482, 8707.521086340248, 8743.0, 8749.343799215085, 8776.736697899074, 8660.48037117775, 8661.956690216508, 8680.0, 8723.214910658007, 8747.868781968276, 41741.1651766966, 41868.371974420406, 41945.37081943773, 42066.0, 42175.36736948948, 3714.572824125233, 3728.272986767581, 3736.4955730976244, 3737.9252414951548, 3752.3808571585655, 32567.674323256702, 33323.83338083318, 33418.665813341795, 33419.3316133676, 33439.3312133756, 5451.945480545183, 5635.7463914123555, 5661.150827375926, 5685.260916080883, 5693.373728889819, 229374.0, 230701.0, 231713.0, 231918.0, 232105.9999999983, 54847.45152548423, 54891.0, 54898.45101549013, 54972.17541736877, 55112.44887551153, 56708.0, 56758.14862777061, 56874.14688779671, 57012.42987570071, 57025.0, 18422.90788546049, 18750.87494750292, 18762.718559221623, 18780.624387512446, 18784.248630054644, 15704.371825127095, 15713.057216567042, 15715.292811823496, 15730.764038539432, 15731.0, 15658.921705391627, 15952.361905523649, 15989.520314390587, 16100.516984490485, 16149.19254037317, 6131.240941576309, 6160.10678451631, 6180.907286390708, 6243.562950593415, 6351.395238452085, 1106.9667909962714, 1120.2830188679252, 1127.2165844737829, 1137.4881303413497, 1137.7098839795965, 26404.20787376382, 26471.73528264731, 26479.0, 26594.86702566475, 27095.458090838467, 1261.2747670089734, 1261.8548866880426, 1262.1165184370977, 1278.4310981613278, 1283.813846992181, 14108.012439129368, 14203.502877399242, 14250.786238206436, 14424.711505769827, 14466.493672721404, 287829.0, 295837.0, 298249.0, 299766.0, 300012.0, 63194.0, 63435.68282158559, 63570.36429635737, 63604.36395636077, 63910.36089639137, 1547.102680445339, 1560.5864445921613, 1573.559403367059, 1575.141547856421, 1587.444394461929, 30915.536266956464, 31544.053678389686, 31680.841595792797, 32137.0, 32549.0, 43508.0, 43790.56209437865, 43793.78103109464, 43816.78091609522, 43879.34180987351, 252719.0, 252882.0, 253934.0, 254461.0, 255500.0, 38502.42246366363, 39542.60457395389, 40287.0, 40291.395629065, 40364.367206951516, 47250.527494724614, 48688.26967595418, 48749.512504874496, 48798.0, 49159.0, 36140.63859361373, 36228.09429764277, 36295.27409451849, 36370.27259454849, 36521.0, 35504.46743298904, 35641.46537801883, 35874.641253588175, 36060.639393606776, 36220.637793621725, 41578.79210603928, 41937.58062419459, 42091.36862946997, 42246.57753422426, 42360.364594531726, 33864.3486606316, 33973.66026339705, 34468.65531344654, 34542.30915381729, 34688.479672804424, 25810.483790323713, 25918.22245332643, 25947.740522594533, 26054.609180861924, 26157.346066348495], "value": 19529.703788678864, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [629.31719084793, 630.8959021761412, 652.2922628947591, 653.9738410463582, 665.40446300561, 23855.64216536753, 24147.39631509213, 24892.87553562232, 24952.999999999978, 25168.496630067388, 25826.35434114148, 26705.0, 26748.465030699375, 26764.330891727717, 26789.33026674334, 6740.932590674104, 6757.999999999987, 6784.253732089466, 6796.456283497333, 6812.557183783063, 6999.930000699978, 7076.540024898391, 7081.114860642419, 7086.3976561992295, 7087.362137407632, 7015.2984701529695, 7042.68307926142, 7047.647617619098, 7050.471214658921, 7057.0, 7002.929970700278, 7007.684654190573, 7043.718251269968, 7044.647767611625, 7055.823604409905, 6523.673816309213, 6569.770058047993, 6586.670666466657, 6596.43930265928, 6621.0, 29777.0, 31894.840525797455, 31981.200469988205, 32040.519392209135, 32166.839165804256, 2306.261996161229, 2309.7921187093075, 2323.18688459038, 2336.0538981712434, 2337.31049340445, 20299.898500507403, 20885.68671469929, 21374.503784735076, 21481.0, 21672.89163554188, 2582.4060466092906, 2641.656584644003, 2643.8942442302287, 2662.2412612405565, 2665.866706664659, 147261.0, 152580.0, 169096.0, 176629.0, 177043.0, 16741.49775506737, 17252.74120888188, 17274.568135796704, 17677.823221767874, 17739.645207095786, 27365.589516157273, 27481.17556473309, 27493.725062749116, 27559.31101722473, 27606.861965690045, 11169.0, 11237.83143252852, 11271.380074096003, 11274.774504509864, 11629.360385178896, 10263.384196948058, 10297.227707921937, 10302.484875756332, 10360.222983276133, 10378.377297362182, 9954.800903982024, 10084.49577521121, 10240.846387304196, 10292.588296468208, 10383.792324153626, 2920.8393538355595, 2987.865546050433, 2999.5200767877473, 3012.502937015368, 3024.0927721683406, 1056.7358160459885, 1071.7856428714288, 1078.6494389323502, 1088.4992903264429, 1090.4547726136932, 21827.67258491124, 21832.126714931543, 21842.932041445383, 21985.560288794135, 22130.778692212873, 1141.0985321596013, 1148.4200478758341, 1153.5039932828963, 1157.1379322404862, 1157.3576664951033, 11478.311301321948, 11899.76200476003, 11922.344271065002, 11934.257144713209, 11951.22317049389, 667999.0, 674210.0, 682366.0, 684288.0, 690437.0, 138916.0, 140279.0, 140704.29647851695, 141449.29275353558, 142198.0, 1164.4352489042808, 1226.760781647588, 1273.331500961984, 1276.4511260158222, 1298.0848501806204, 22358.552828943004, 22657.660135097656, 22855.885720571292, 23032.193873214357, 23046.76953230446, 66321.33678663151, 66931.33068669446, 67957.0, 68500.31499685139, 70104.29895701182, 82063.0, 85905.57047214724, 86092.56953715441, 86274.0, 86556.0, 15907.761383579023, 15992.120433376276, 16091.517254482384, 16152.11163386025, 16282.755758663867, 24118.0, 24399.634005489577, 24411.633825492987, 24488.387790305384, 24811.751882480945, 19448.0, 19926.202951882344, 20074.498137546096, 20117.79882201159, 20263.696044559638, 17604.823951760318, 17788.733169002215, 18004.279828806702, 18038.0, 18412.26350945947, 20113.899430502755, 20166.193352265745, 20267.69598455995, 20579.382618521468, 20619.793802061788, 15832.366705331659, 15870.841291587398, 15915.124668143364, 15943.920280398524, 15957.0, 19250.326238581583, 19407.708884366464, 19629.70555441641, 20051.197952081755, 20068.498287542927], "value": 13367.831298146959, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1396.8114304568883, 1459.233902201344, 1461.6126726417508, 1469.9706005879882, 1477.9334929928152, 17574.82425175748, 19005.61988760224, 19079.904600477013, 19105.42683719487, 19130.043497825107, 18484.2606295748, 19017.52456188596, 19030.809691903076, 19039.52401189971, 19047.333343332986, 3073.6004319438553, 3081.845907704617, 3152.4956007038877, 3152.858121384532, 3168.9207769805826, 3082.352705931757, 3101.5192645139928, 3146.8898588549405, 3150.3226806236653, 3151.5115157150562, 3092.3815236952587, 3159.0680749179046, 3162.0355791483703, 3198.344339410415, 3200.9839950800215, 3101.782875198737, 3114.9688503114903, 3138.0428969164395, 3139.30935194258, 3140.576022237003, 2998.625171853518, 2999.5650630658433, 3016.4268788930035, 3034.0442760530364, 3035.8178509289514, 17205.139743012798, 17444.738328925076, 17481.388151414638, 17589.12054397275, 17642.029688367136, 8982.775430614221, 9180.31147663928, 9254.722358329262, 9262.120098590623, 9269.536523173814, 5879.088741245071, 5946.940530594682, 6114.847128821771, 6132.570720049598, 6167.84580385494, 2078.1064142418754, 2080.136743251549, 2098.916043358264, 2107.283523601983, 2151.956960860774, 32671.346573068644, 33024.17439564006, 33100.66899331, 33114.6688533114, 33230.66769332324, 7764.534127952228, 7804.8829267559895, 7824.139344672081, 7881.093674227537, 8054.23484768946, 20761.37715868496, 20784.896075519526, 20803.271885483937, 20824.47938801542, 20883.37349879506, 8946.329025322997, 9098.727038188865, 9099.272058235325, 9107.271418286522, 9112.22546083577, 8306.169383061646, 8312.709055183039, 8350.791230219293, 8373.120822313691, 8379.455335403301, 5866.442687944638, 6034.9396506035255, 6087.54343424245, 6132.601380910227, 6367.299597044322, 1796.8652351073722, 1812.9274829006956, 1823.507652933727, 1838.2555065198349, 1845.8800177988387, 874.1258741258741, 1009.6163457885956, 1022.754538910656, 1031.834027548865, 1056.10758908722, 10021.849672254923, 10194.337368071052, 10253.641122560675, 10275.486225688686, 10300.124489418484, 783.894174286464, 819.6434550970347, 836.2682652678906, 843.5065486690355, 914.3005600715458, 6150.907736383869, 6247.843803904939, 6397.616143031433, 6427.839304017437, 6618.497109826628, 25886.48227035449, 27237.182884513495, 27522.862385688342, 27522.899084036813, 27949.16152515428, 26280.86859565728, 27229.727702723114, 27310.0, 27364.45271094567, 27545.311367215578, 13042.478300867859, 13148.276844773629, 13378.732425351438, 13404.5308414207, 13406.32968351598, 9451.149396554343, 9559.856602150834, 9574.03732234904, 9603.087706667855, 9758.512074396394, 22279.10883564639, 22288.665670014638, 22499.550008999402, 22864.77135228693, 22880.855957202406, 23259.767402326437, 23398.298051058497, 23907.641385378884, 23934.28197154088, 24032.63951040771, 12577.93711031439, 12731.2997785119, 12799.360031998549, 12821.0, 12895.355232238539, 16331.918340408221, 16560.50318490447, 16562.337506499603, 16572.254248558602, 16576.336946522006, 12853.485860565472, 12872.742545149233, 12892.0, 12947.805782913076, 13030.478780849038, 12576.811347829607, 12746.936265318614, 12966.286854223108, 13102.410391532594, 13195.076344655781, 11315.151363647925, 11400.714982125513, 11409.714757131138, 11484.253523520945, 11541.826872597087, 8493.702720404755, 8532.274756645505, 8654.22112009922, 8721.302295816446, 8740.694075707319, 8441.70454034106, 8450.535220562928, 8560.0, 8733.30133589324, 8745.91254087451], "value": 7772.429575486257, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [574.6580784433261, 585.979490717825, 590.2120668907007, 604.5586721693164, 614.9938500614995, 6277.968610156949, 6295.905561416571, 6298.811035668931, 6333.493320534358, 6359.936400635992, 6173.166622505961, 6176.197094377724, 6189.769644650263, 6206.813795586128, 6291.874162516759, 5199.532042116209, 5219.791208351661, 5222.477752224776, 5226.973865130669, 5230.869228269305, 4920.3111564381015, 5137.974310128444, 5186.688798672073, 5206.271122042917, 5213.973930130344, 5001.799928002875, 5024.974875125619, 5040.571551418134, 5051.79792808289, 5055.266986286986, 5021.522955319276, 5031.0, 5072.492750724917, 5080.41575218849, 5091.472558232553, 4533.6146427553695, 4615.792289346954, 4632.513586073447, 4635.884102897421, 4646.767661616939, 6066.423689749511, 6182.783602573888, 6190.783322583688, 6220.937790622126, 6240.31356550779, 5936.198613187251, 5939.683523425867, 5945.900008498442, 5967.134765459027, 5985.191999080112, 6487.740490380379, 6565.179352580927, 6595.53831231814, 6617.735290588371, 6621.536492445531, 5069.467705890902, 5091.414487333967, 5094.286799848024, 5127.102757017545, 5136.64043516954, 6664.866702665968, 6788.8302792430095, 6878.621675807829, 6917.654117294165, 6974.686139123752, 5230.97384513075, 5246.685198888079, 5256.342957130359, 5272.314599102092, 5293.417724050351, 5327.786888524415, 5337.306150200449, 5377.677339359573, 5397.70312632809, 5398.298221231294, 5871.3541510433815, 5874.412558744091, 5897.705114744332, 5898.466398736359, 5924.526037916957, 6679.966600166968, 6681.42986398196, 6697.330266973264, 6708.825955457775, 6727.596344219264, 1842.8802127861645, 1845.4186931116656, 1857.8792378495355, 1866.56135808085, 1877.9906100469411, 1272.0840994483956, 1307.3332600373878, 1319.5381616434363, 1331.7814200007078, 1344.522694443478, 6254.2807577129215, 6269.780557680459, 6303.149074874925, 6320.62076275425, 6331.493480521547, 6597.373249541286, 6603.438707709803, 6721.655668866247, 6820.590764554143, 6849.842299675586, 6369.17200763907, 6380.585261957958, 6398.840028999219, 6400.967995159995, 6411.455026322815, 3536.45184996326, 3538.3807833629526, 3538.610752817188, 3555.9418899746197, 3556.78659280444, 6984.825379365557, 7068.646567671699, 7071.92928070723, 7076.787696369117, 7081.0, 6896.827579310558, 6914.274001229899, 6924.896126558106, 6942.444604431735, 6999.8600027999155, 7033.366996970297, 7059.25877782846, 7086.362227399559, 7091.184513780981, 7121.82195445118, 6686.3313668632745, 6733.124693789776, 6734.8653026940165, 6763.7632682855865, 6805.0472933788315, 6718.899216511854, 6733.69698363565, 6763.2898545652, 6787.253402125861, 6792.558483698742, 6990.965045174741, 7052.82367940785, 7079.646017698991, 7088.255733147946, 7092.5389849659605, 5189.949969761999, 5205.713685747321, 5249.086756849985, 5277.076511610376, 5287.339082614673, 6482.870342593216, 6652.268250492539, 6660.766873159416, 6769.153855768029, 6780.525363224527, 6465.709043092978, 6519.7392104315295, 6608.4382827458285, 6617.8014659560295, 6635.933640663531, 6453.645049522322, 6547.279799221987, 6577.177852768404, 6578.736850525926, 6626.801195964129, 6301.590396624205, 6386.584871983307, 6505.934940650723, 6570.507211959218, 6579.276279609335, 6529.706163222571, 6565.441937435371, 6571.704273307617, 6572.244191917991, 6625.801225963229, 6360.268569114611, 6387.329330420239, 6421.5825971311715, 6491.513136514686, 6526.379993900572], "value": 5232.063773140477, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1009.8131845608563, 1016.2073582605566, 1035.3839465518017, 1036.9896301036988, 1040.2094408249732, 18704.906475467622, 19452.90273548632, 19488.99999999998, 21832.454188645293, 22358.66462003067, 22342.329730108122, 22617.321480355615, 22832.65751013732, 23643.527129457445, 23734.287971360885, 1104.5913012185483, 1135.2053562506237, 1135.5401062569672, 1135.585511288378, 1137.772445510897, 991.2317953585956, 1094.529352378477, 1104.6354702948008, 1120.5741818109107, 1121.327203677791, 1170.1165619956962, 1170.391396473833, 1171.344047333496, 1171.6485054483664, 1174.6476057182854, 1156.5200441816721, 1157.5254145800225, 1159.2928313728619, 1166.1894982986828, 1168.5559487394778, 856.7558245899888, 858.1204265627719, 860.8106216632331, 861.5649097205871, 861.9655213791441, 19936.0, 20576.38270851877, 20581.4854628634, 20691.689624655643, 20901.477463063395, 24076.638850417083, 24088.518229635483, 24189.87905060481, 24513.264602061965, 24548.754512454827, 19489.707654385194, 19718.70421943672, 19762.80237197624, 19783.40649780509, 19870.602587948306, 3923.7253392262555, 3965.5637879833193, 3972.960270397288, 3975.0062484378905, 3976.324024915771, 161661.0, 165156.0, 166223.0, 166365.16817415957, 168420.0, 18676.43970680882, 19000.904995474935, 19005.14476848545, 19009.76436531621, 19052.237910483702, 29371.41257174887, 34985.65014349875, 36078.458823117675, 36088.63911360853, 36115.458268126, 9226.169644732006, 10764.677059688222, 10809.78380432387, 10860.076893464144, 10901.509432075576, 4982.07831551157, 5061.063703214917, 5077.568406685399, 5122.154844450699, 5132.948670513321, 6181.350958149419, 6347.143135676717, 6461.353864613595, 6464.676766161673, 6495.0, 1210.8244304575787, 1223.5534030079134, 1247.8502579690496, 1248.6441364211157, 1251.0367017396736, 635.5106567942751, 666.2338310942358, 674.6592970549841, 680.43863812355, 686.8111269400955, 11567.942160289145, 11679.474423650956, 11808.202774174166, 12550.372481376076, 12727.427265773062, 718.989215161773, 721.5165838887958, 723.5333210079469, 734.8603765284579, 742.3912391838641, 5928.318243401977, 5941.0, 5941.762329506858, 5979.222701048836, 6020.946334391464, 154805.2259738694, 155253.22373388286, 158268.0, 158494.0, 160104.0, 137961.0, 143554.28222858818, 143666.0, 144334.0, 146230.0, 123317.0, 123747.38126309491, 124607.0, 125172.0, 126754.0, 10887.292325998786, 10890.891091089305, 10984.505697243483, 11099.223054386115, 11340.036096931854, 59362.70318648379, 59391.40608594032, 59515.0, 59826.401735983825, 60624.0, 74672.25327746653, 77307.0, 78253.0, 78303.0, 78870.0, 14355.425782968565, 14828.925855371086, 14890.702185956437, 15179.013364131297, 16215.35138594443, 19235.0, 19653.11560979788, 19779.901100494404, 19838.702419464007, 19843.40469785909, 17794.46616601504, 17802.287908483515, 17870.374536891148, 18024.819751802315, 18118.5470363242, 17531.21109550048, 17715.114244287994, 17823.376181833573, 17894.821051789317, 17897.642047159243, 17397.30410783605, 17475.82524174742, 17524.123793810515, 17622.030788306765, 17712.114394280492, 14236.572902812932, 14276.643083922985, 14346.426142954166, 14371.0, 14438.0, 12865.549705760253, 13006.609801705965, 13219.603411897659, 13227.933860330637, 13404.061715679809], "value": 10187.796429234382, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1355.3999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 103.0, 105.0, 106.0, 106.0, 107.0, 106.0, 106.0, 104.0, 106.0], "value": 105.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 115.0, 113.0, 111.0, 110.0, 111.0, 140.0, 112.0, 111.0, 142.0], "value": 117.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 164.0, 161.0, 162.0, 161.0, 163.0, 161.0, 162.0, 162.0], "value": 162.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 74.0, 72.0, 73.0, 74.0, 74.0, 73.0, 74.0, 73.0, 72.0], "value": 73.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 77.0, 76.0, 77.0, 76.0, 77.0, 76.0, 77.0, 76.0, 77.0], "value": 76.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 114.0, 114.0, 110.0, 114.0, 114.0, 114.0, 111.0, 114.0, 116.0], "value": 113.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 147.0, 148.0, 148.0, 149.0, 149.0, 148.0, 148.0, 150.0, 149.0], "value": 148.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 99.0, 95.0, 94.0, 94.0, 94.0, 94.0, 95.0, 94.0, 99.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [45.0, 42.0, 42.0, 43.0, 44.0, 49.0, 44.0, 45.0, 45.0, 44.0], "value": 44.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [39.0, 39.0, 38.0, 38.0, 38.0, 39.0, 40.0, 38.0, 39.0, 39.0], "value": 38.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 72.0, 68.0, 69.0, 70.0, 68.0, 69.0, 70.0, 68.0, 71.0], "value": 69.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 103.0, 113.0, 101.0, 103.0, 107.0, 105.0, 102.0, 106.0, 103.0], "value": 104.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 146.0, 150.0, 146.0, 142.0, 147.0, 143.0, 151.0, 145.0, 157.0], "value": 148.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 60.0, 59.0, 59.0, 57.0, 57.0, 57.0, 57.0, 55.0, 61.0], "value": 58.0, "unit": "score"}]}]} 10:48:03 INFO - Return code: 0 10:48:03 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:48:03 INFO - # TBPL SUCCESS # 10:48:03 INFO - Running post-action listener: _package_coverage_data 10:48:03 INFO - Running post-action listener: _resource_record_post_action 10:48:03 INFO - [mozharness: 2017-10-09 17:48:03.654321Z] Finished run-tests step (success) 10:48:03 INFO - Running post-run listener: _resource_record_post_run 10:48:03 INFO - Total resource usage - Wall time: 1187s; CPU: 13.0%; Read bytes: 8871936; Write bytes: 420433920; Read time: 1952; Write time: 590936 10:48:03 INFO - TinderboxPrint: CPU usage
13.1% 10:48:03 INFO - TinderboxPrint: I/O read bytes / time
8,871,936 / 1,952 10:48:03 INFO - TinderboxPrint: I/O write bytes / time
420,433,920 / 590,936 10:48:03 INFO - TinderboxPrint: CPU idle
8,225.7 (86.9%) 10:48:03 INFO - TinderboxPrint: CPU user
1,179.3 (12.5%) 10:48:03 INFO - TinderboxPrint: Swap in / out
0 / 0 10:48:03 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 0; Write bytes: 12480512; Read time: 0; Write time: 1656 10:48:03 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 10:48:03 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 8871936; Write bytes: 407953408; Read time: 1952; Write time: 589280 10:48:04 INFO - Running post-run listener: _upload_blobber_files 10:48:04 INFO - Blob upload gear active. 10:48:04 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:48:04 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 10:48:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 10:48:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 10:48:04 INFO - (blobuploader) - INFO - Open directory for files ... 10:48:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 10:48:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:48:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:48:06 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 10:48:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:48:06 INFO - (blobuploader) - INFO - Done attempting. 10:48:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:48:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:48:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:48:14 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:48:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:48:14 INFO - (blobuploader) - INFO - Done attempting. 10:48:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 10:48:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:48:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:48:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 10:48:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:48:15 INFO - (blobuploader) - INFO - Done attempting. 10:48:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 10:48:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:48:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:48:16 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 10:48:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:48:16 INFO - (blobuploader) - INFO - Done attempting. 10:48:16 INFO - (blobuploader) - INFO - Iteration through files over. 10:48:16 INFO - Return code: 0 10:48:16 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:48:16 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:48:16 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/1389a5d2b1aac036efbb719feccaae14df6cb4d981e4caac29433cb9e7d90a5e1482fe5b902e62f19cc4a19204647eb61483e81c044efaa7334000611cbf993e", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/50628adf2e6c4a3ce0459f66cd86d7a8af1bdfe12ba3b0c1e1b4fb825706a4e6072d304159c73eed600d304a6da5c0fa75ef6d528858c0f0172d3dba601ead45", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/0a6c37d1e9310be172c2222ddab58762bb0a36ba08a1d253aa0b62cbc271ad2b414880c9d978e96aaa588cb084275831d50ff8f2d8c5de329f60d7ca5066506e", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/39b0b153bfc9f918fee826c23b1dd8fdbfc7bba39705885248f166be8514c518ce9c8118e1e952b7200cf52a5af5633040f269d26c66f20b1d8edf6916684922"} 10:48:16 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:48:16 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:48:16 INFO - Contents: 10:48:16 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/1389a5d2b1aac036efbb719feccaae14df6cb4d981e4caac29433cb9e7d90a5e1482fe5b902e62f19cc4a19204647eb61483e81c044efaa7334000611cbf993e", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/50628adf2e6c4a3ce0459f66cd86d7a8af1bdfe12ba3b0c1e1b4fb825706a4e6072d304159c73eed600d304a6da5c0fa75ef6d528858c0f0172d3dba601ead45", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/0a6c37d1e9310be172c2222ddab58762bb0a36ba08a1d253aa0b62cbc271ad2b414880c9d978e96aaa588cb084275831d50ff8f2d8c5de329f60d7ca5066506e", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/39b0b153bfc9f918fee826c23b1dd8fdbfc7bba39705885248f166be8514c518ce9c8118e1e952b7200cf52a5af5633040f269d26c66f20b1d8edf6916684922"} 10:48:16 INFO - Running post-run listener: copy_logs_to_upload_dir 10:48:16 INFO - Copying logs to upload dir... 10:48:16 INFO - mkdir: /builds/slave/test/build/upload/logs 10:48:16 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1245.570796 ========= master_lag: 0.32 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2017-10-09 10:48:16.617700) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-10-09 10:48:16.621079) ========= 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=df17445c3590ff7897617a0e00000225-1507570017.810534-660076180 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/1389a5d2b1aac036efbb719feccaae14df6cb4d981e4caac29433cb9e7d90a5e1482fe5b902e62f19cc4a19204647eb61483e81c044efaa7334000611cbf993e", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/50628adf2e6c4a3ce0459f66cd86d7a8af1bdfe12ba3b0c1e1b4fb825706a4e6072d304159c73eed600d304a6da5c0fa75ef6d528858c0f0172d3dba601ead45", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/0a6c37d1e9310be172c2222ddab58762bb0a36ba08a1d253aa0b62cbc271ad2b414880c9d978e96aaa588cb084275831d50ff8f2d8c5de329f60d7ca5066506e", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/39b0b153bfc9f918fee826c23b1dd8fdbfc7bba39705885248f166be8514c518ce9c8118e1e952b7200cf52a5af5633040f269d26c66f20b1d8edf6916684922"} build_url:https://queue.taskcluster.net/v1/task/V7HEWaOjRfWkeHPKF2AjDg/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011324 build_url: 'https://queue.taskcluster.net/v1/task/V7HEWaOjRfWkeHPKF2AjDg/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/1389a5d2b1aac036efbb719feccaae14df6cb4d981e4caac29433cb9e7d90a5e1482fe5b902e62f19cc4a19204647eb61483e81c044efaa7334000611cbf993e", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/50628adf2e6c4a3ce0459f66cd86d7a8af1bdfe12ba3b0c1e1b4fb825706a4e6072d304159c73eed600d304a6da5c0fa75ef6d528858c0f0172d3dba601ead45", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/0a6c37d1e9310be172c2222ddab58762bb0a36ba08a1d253aa0b62cbc271ad2b414880c9d978e96aaa588cb084275831d50ff8f2d8c5de329f60d7ca5066506e", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/39b0b153bfc9f918fee826c23b1dd8fdbfc7bba39705885248f166be8514c518ce9c8118e1e952b7200cf52a5af5633040f269d26c66f20b1d8edf6916684922"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-10-09 10:48:16.650330) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-10-09 10:48:16.650670) ========= 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=df17445c3590ff7897617a0e00000225-1507570017.810534-660076180 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004539 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-10-09 10:48:16.706916) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-10-09 10:48:16.707232) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-10-09 10:48:16.707547) ========= ========= Total master_lag: 0.46 =========