builder: mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s-pgo slave: talos-linux64-ix-029 starttime: 1506538648.36 results: success (0) revision: 756e10aa8bbd416cbc49b7739f78fb81d5525477 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-27 11:57:28.357004) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-27 11:57:28.357429) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-27 11:57:28.357700) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-27 11:57:28.370812) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-27 11:57:28.371243) ========= 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=ba164b0a7b0ec7655860e956000001c1-1506538647.591657-324272956 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-27 11:57: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.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 91.8M=0s 2017-09-27 11:57:29 (91.8 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.363801 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-27 11:57:28.750052) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-27 11:57:28.750391) ========= 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=ba164b0a7b0ec7655860e956000001c1-1506538647.591657-324272956 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019195 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-27 11:57:28.806236) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-27 11:57:28.806567) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 756e10aa8bbd416cbc49b7739f78fb81d5525477 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo mozilla-central --rev 756e10aa8bbd416cbc49b7739f78fb81d5525477 --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=ba164b0a7b0ec7655860e956000001c1-1506538647.591657-324272956 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-27 11:57:29,365 truncating revision to first 12 chars 2017-09-27 11:57:29,366 Setting DEBUG logging. 2017-09-27 11:57:29,366 attempt 1/10 2017-09-27 11:57:29,366 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/756e10aa8bbd?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-27 11:57:29,968 unpacking tar archive at: mozilla-central-756e10aa8bbd/testing/mozharness/ program finished with exit code 0 elapsedTime=0.924563 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-27 11:57:29.752697) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-27 11:57:29.756070) ========= script_repo_revision: 756e10aa8bbd416cbc49b7739f78fb81d5525477 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-27 11:57:29.756456) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-27 11:57:29.756715) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-27 11:57:29.771686) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2017-09-27 11:57:29.772065) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-stylo-disabled-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-stylo-disabled-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=ba164b0a7b0ec7655860e956000001c1-1506538647.591657-324272956 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:57:30 INFO - MultiFileLogger online at 20170927 11:57:30 in /builds/slave/test 11:57:30 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-stylo-disabled-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 11:57:30 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:57:30 INFO - {'append_to_log': False, 11:57:30 INFO - 'base_work_dir': '/builds/slave/test', 11:57:30 INFO - 'blob_upload_branch': 'Firefox', 11:57:30 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:57:30 INFO - 'branch': 'Firefox', 11:57:30 INFO - 'buildbot_json_path': 'buildprops.json', 11:57:30 INFO - 'code_coverage': False, 11:57:30 INFO - 'config_files': ('talos/linux_config.py',), 11:57:30 INFO - 'default_actions': ('clobber', 11:57:30 INFO - 'read-buildbot-config', 11:57:30 INFO - 'download-and-extract', 11:57:30 INFO - 'populate-webroot', 11:57:30 INFO - 'create-virtualenv', 11:57:30 INFO - 'install', 11:57:30 INFO - 'setup-mitmproxy', 11:57:30 INFO - 'run-tests'), 11:57:30 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:57:30 INFO - 'disable_ccov_upload': False, 11:57:30 INFO - 'disable_stylo': False, 11:57:30 INFO - 'download_minidump_stackwalk': True, 11:57:30 INFO - 'download_symbols': 'ondemand', 11:57:30 INFO - 'enable_stylo': False, 11:57:30 INFO - 'enable_webrender': False, 11:57:30 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 11:57:30 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:57:30 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:57:30 INFO - 'gecko_profile': False, 11:57:30 INFO - 'gecko_profile_interval': 0, 11:57:30 INFO - 'installer_path': 'installer.exe', 11:57:30 INFO - 'log_level': 'info', 11:57:30 INFO - 'log_name': 'talos', 11:57:30 INFO - 'log_to_console': True, 11:57:30 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:57:30 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:57:30 INFO - 'opt_config_files': (), 11:57:30 INFO - 'pip_index': False, 11:57:30 INFO - 'suite': 'dromaeojs-stylo-disabled-e10s', 11:57:30 INFO - 'system_bits': '32', 11:57:30 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:57:30 INFO - 'title': 'talos-linux64-ix-029', 11:57:30 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:57:30 INFO - 'use_talos_json': True, 11:57:30 INFO - 'verify': 'False', 11:57:30 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:57:30 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:57:30 INFO - 'work_dir': 'build'} 11:57:30 INFO - [mozharness: 2017-09-27 18:57:30.465139Z] Running clobber step. 11:57:30 INFO - Running pre-action listener: _resource_record_pre_action 11:57:30 INFO - Running main action method: clobber 11:57:30 INFO - rmtree: /builds/slave/test/build 11:57:30 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:57:31 INFO - Running post-action listener: _resource_record_post_action 11:57:31 INFO - [mozharness: 2017-09-27 18:57:31.450960Z] Finished clobber step (success) 11:57:31 INFO - [mozharness: 2017-09-27 18:57:31.451058Z] Running read-buildbot-config step. 11:57:31 INFO - Running pre-action listener: _resource_record_pre_action 11:57:31 INFO - Running main action method: read_buildbot_config 11:57:31 INFO - Using buildbot properties: 11:57:31 INFO - { 11:57:31 INFO - "project": "", 11:57:31 INFO - "product": "firefox", 11:57:31 INFO - "who": "ffxbld@noreply.mozilla.org", 11:57:31 INFO - "installer_path": "public/build/target.tar.bz2", 11:57:31 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s", 11:57:31 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 11:57:31 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-stylo-disabled-e10s", 11:57:31 INFO - "stage_platform": "linux64-pgo", 11:57:31 INFO - "basedir": "/builds/slave/test", 11:57:31 INFO - "buildnumber": 66, 11:57:31 INFO - "platform": "ubuntu64_hw", 11:57:31 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 11:57:31 INFO - "slavebuilddir": "test", 11:57:31 INFO - "taskId": "Iz5cuvlnRaeOO1VcuNY_pQ", 11:57:31 INFO - "branch": "mozilla-central", 11:57:31 INFO - "script_repo_revision": "production", 11:57:31 INFO - "revision": "756e10aa8bbd416cbc49b7739f78fb81d5525477", 11:57:31 INFO - "slavename": "talos-linux64-ix-029", 11:57:31 INFO - "repo_path": "mozilla-central" 11:57:31 INFO - } 11:57:31 INFO - Finding installer, test and symbols from parent task. 11:57:31 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Iz5cuvlnRaeOO1VcuNY_pQ'}, attempt #1 11:57:31 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Iz5cuvlnRaeOO1VcuNY_pQ'}, attempt #1 11:57:32 INFO - Task dependencies: PBHu4AnVT_OJapiiUJnugg 11:57:32 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/PBHu4AnVT_OJapiiUJnugg'}, attempt #1 11:57:32 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/PBHu4AnVT_OJapiiUJnugg/artifacts/public/build/target.tar.bz2 11:57:32 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/PBHu4AnVT_OJapiiUJnugg/artifacts/public/build/target.test_packages.json 11:57:32 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/PBHu4AnVT_OJapiiUJnugg/artifacts/public/build/target.crashreporter-symbols.zip 11:57:32 INFO - Running post-action listener: _resource_record_post_action 11:57:32 INFO - [mozharness: 2017-09-27 18:57:32.949053Z] Finished read-buildbot-config step (success) 11:57:32 INFO - [mozharness: 2017-09-27 18:57:32.949271Z] Running download-and-extract step. 11:57:32 INFO - Running pre-action listener: _resource_record_pre_action 11:57:32 INFO - Running main action method: download_and_extract 11:57:32 INFO - mkdir: /builds/slave/test/build/tests 11:57:32 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')]} 11:57:32 INFO - trying https://queue.taskcluster.net/v1/task/PBHu4AnVT_OJapiiUJnugg/artifacts/public/build/target.test_packages.json 11:57:32 INFO - Downloading https://queue.taskcluster.net/v1/task/PBHu4AnVT_OJapiiUJnugg/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 11:57:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/PBHu4AnVT_OJapiiUJnugg/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 11:57:33 INFO - Downloaded 989 bytes. 11:57:33 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 11:57:33 INFO - Using the following test package requirements: 11:57:33 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 11:57:33 INFO - u'common': [u'target.common.tests.zip'], 11:57:33 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 11:57:33 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 11:57:33 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 11:57:33 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 11:57:33 INFO - u'mozbase': [u'target.common.tests.zip'], 11:57:33 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 11:57:33 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 11:57:33 INFO - u'web-platform': [u'target.common.tests.zip', 11:57:33 INFO - u'target.web-platform.tests.tar.gz'], 11:57:33 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 11:57:33 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 11:57:33 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/PBHu4AnVT_OJapiiUJnugg/artifacts/public/build/target.common.tests.zip 11:57:33 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/PBHu4AnVT_OJapiiUJnugg/artifacts/public/build/target.common.tests.zip'}, attempt #1 11:57:33 INFO - Fetch https://queue.taskcluster.net/v1/task/PBHu4AnVT_OJapiiUJnugg/artifacts/public/build/target.common.tests.zip into memory 11:57:34 INFO - Content-Length response header: 55348979 11:57:34 INFO - Bytes received: 55348979 11:57:46 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/PBHu4AnVT_OJapiiUJnugg/artifacts/public/build/target.talos.tests.zip 11:57:46 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/PBHu4AnVT_OJapiiUJnugg/artifacts/public/build/target.talos.tests.zip'}, attempt #1 11:57:46 INFO - Fetch https://queue.taskcluster.net/v1/task/PBHu4AnVT_OJapiiUJnugg/artifacts/public/build/target.talos.tests.zip into memory 11:57:46 INFO - Content-Length response header: 14513665 11:57:46 INFO - Bytes received: 14513665 11:57:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:57:46 INFO - trying https://queue.taskcluster.net/v1/task/PBHu4AnVT_OJapiiUJnugg/artifacts/public/build/target.tar.bz2 11:57:46 INFO - Downloading https://queue.taskcluster.net/v1/task/PBHu4AnVT_OJapiiUJnugg/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 11:57:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/PBHu4AnVT_OJapiiUJnugg/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 11:57:48 INFO - Downloaded 62317430 bytes. 11:57:48 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/PBHu4AnVT_OJapiiUJnugg/artifacts/public/build/target.tar.bz2 11:57:48 INFO - mkdir: /builds/slave/test/properties 11:57:48 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:57:48 INFO - Writing to file /builds/slave/test/properties/build_url 11:57:48 INFO - Contents: 11:57:48 INFO - build_url:https://queue.taskcluster.net/v1/task/PBHu4AnVT_OJapiiUJnugg/artifacts/public/build/target.tar.bz2 11:57:48 INFO - Running post-action listener: _resource_record_post_action 11:57:48 INFO - Running post-action listener: find_tests_for_verification 11:57:48 INFO - Running post-action listener: set_extra_try_arguments 11:57:48 INFO - [mozharness: 2017-09-27 18:57:48.169597Z] Finished download-and-extract step (success) 11:57:48 INFO - [mozharness: 2017-09-27 18:57:48.169695Z] Running populate-webroot step. 11:57:48 INFO - Running pre-action listener: _resource_record_pre_action 11:57:48 INFO - Running main action method: populate_webroot 11:57:48 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:57:48 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:57:48 INFO - 'tests': ['tresize', 11:57:48 INFO - 'tcanvasmark']}, 11:57:48 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:57:48 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:57:48 INFO - 'tests': ['dromaeo_css', 11:57:48 INFO - 'kraken']}, 11:57:48 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 11:57:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:57:48 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:57:48 INFO - 'talos_options': ['--disable-stylo'], 11:57:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:57:48 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 11:57:48 INFO - 'tests': ['damp', 'tps']}, 11:57:48 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:57:48 INFO - 'talos_options': ['--disable-stylo'], 11:57:48 INFO - 'tests': ['damp', 'tps']}, 11:57:48 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:57:48 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:57:48 INFO - 'tests': ['dromaeo_dom']}, 11:57:48 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 11:57:48 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:57:48 INFO - 'tests': ['basic_compositor_video', 11:57:48 INFO - 'glvideo']}, 11:57:48 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 11:57:48 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 11:57:48 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:57:48 INFO - 'talos_options': ['--disable-stylo'], 11:57:48 INFO - 'tests': ['ts_paint_webext', 11:57:48 INFO - 'tp5o_webext']}, 11:57:48 INFO - 'other-e10s': {'tests': ['a11yr', 11:57:48 INFO - 'ts_paint', 11:57:48 INFO - 'tpaint', 11:57:48 INFO - 'sessionrestore', 11:57:48 INFO - 'sessionrestore_many_windows', 11:57:48 INFO - 'sessionrestore_no_auto_restore', 11:57:48 INFO - 'tabpaint']}, 11:57:48 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:57:48 INFO - 'tests': ['a11yr', 11:57:48 INFO - 'ts_paint', 11:57:48 INFO - 'tpaint', 11:57:48 INFO - 'sessionrestore', 11:57:48 INFO - 'sessionrestore_many_windows', 11:57:48 INFO - 'sessionrestore_no_auto_restore', 11:57:48 INFO - 'tabpaint']}, 11:57:48 INFO - 'perf-reftest-e10s': {'tests': ['perf_reftest']}, 11:57:48 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 11:57:48 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:57:48 INFO - 'tests': ['perf_reftest_singletons']}, 11:57:48 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:57:48 INFO - 'tests': ['perf_reftest']}, 11:57:48 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:57:48 INFO - 'tsvgr_opacity', 11:57:48 INFO - 'tart', 11:57:48 INFO - 'tscrollx', 11:57:48 INFO - 'tsvg_static']}, 11:57:48 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:57:48 INFO - 'tests': ['tsvgx', 11:57:48 INFO - 'tsvgr_opacity', 11:57:48 INFO - 'tart', 11:57:48 INFO - 'tscrollx', 11:57:48 INFO - 'tsvg_static']}, 11:57:48 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 11:57:48 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:57:48 INFO - 'talos_options': ['--disable-stylo'], 11:57:48 INFO - 'tests': ['tp5o']}, 11:57:48 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:57:48 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 11:57:48 INFO - 'talos_options': ['--mitmproxy', 11:57:48 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:57:48 INFO - '--firstNonBlankPaint'], 11:57:48 INFO - 'tests': ['tp6_google', 11:57:48 INFO - 'tp6_youtube', 11:57:48 INFO - 'tp6_amazon', 11:57:48 INFO - 'tp6_facebook']}, 11:57:48 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:57:48 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 11:57:48 INFO - 'talos_options': ['--disable-stylo', 11:57:48 INFO - '--mitmproxy', 11:57:48 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:57:48 INFO - '--firstNonBlankPaint'], 11:57:48 INFO - 'tests': ['tp6_google', 11:57:48 INFO - 'tp6_youtube', 11:57:48 INFO - 'tp6_amazon', 11:57:48 INFO - 'tp6_facebook']}, 11:57:48 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:57:48 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 11:57:48 INFO - 'talos_options': ['--stylo-threads=1', 11:57:48 INFO - '--mitmproxy', 11:57:48 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:57:48 INFO - '--firstNonBlankPaint'], 11:57:48 INFO - 'tests': ['tp6_google', 11:57:48 INFO - 'tp6_youtube', 11:57:48 INFO - 'tp6_amazon', 11:57:48 INFO - 'tp6_facebook']}, 11:57:48 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 11:57:48 INFO - 'talos_options': ['--xperf_path', 11:57:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:57:48 INFO - 'tests': ['tp5n']}, 11:57:48 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:57:48 INFO - 'talos_options': ['--disable-stylo', 11:57:48 INFO - '--xperf_path', 11:57:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:57:48 INFO - 'tests': ['tp5n']}}} 11:57:48 INFO - Running post-action listener: _resource_record_post_action 11:57:48 INFO - [mozharness: 2017-09-27 18:57:48.185883Z] Finished populate-webroot step (success) 11:57:48 INFO - [mozharness: 2017-09-27 18:57:48.185990Z] Running create-virtualenv step. 11:57:48 INFO - Running pre-action listener: _resource_record_pre_action 11:57:48 INFO - Running main action method: create_virtualenv 11:57:48 INFO - Creating virtualenv /builds/slave/test/build/venv 11:57:48 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 11:57:48 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 11:57:48 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 11:57:48 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:57:48 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:57:50 INFO - Installing distribute.............................................................................................................................................................................................done. 11:57:51 INFO - Installing pip...............done. 11:57:51 INFO - Return code: 0 11:57:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 11:57:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 11:57:51 INFO - Reading from file tmpfile_stdout 11:57:51 INFO - Output received: 11:57: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) 11:57:51 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:57: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')]} 11:57:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:57: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')]} 11:57:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:57: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 0x1e0d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fd5b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x217a9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2177d60>, '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 0x2178a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2178ef0>, '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': 'ba164b0a7b0ec7655860e956000001c1-1506538647.591657-324272956', '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 11:57: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 11:57: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 11:57:51 INFO - Using env: {'DISPLAY': ':0', 11:57:51 INFO - 'HOME': '/home/cltbld', 11:57:51 INFO - 'LANG': 'en_US.UTF-8', 11:57:51 INFO - 'LANGUAGE': 'en_US:en', 11:57:51 INFO - 'LOGNAME': 'cltbld', 11:57:51 INFO - 'MAIL': '/var/mail/cltbld', 11:57:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:57:51 INFO - 'MOZ_NO_REMOTE': '1', 11:57:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:57:51 INFO - 'NO_EM_RESTART': '1', 11:57:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:57:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:57:51 INFO - 'PWD': '/builds/slave/test', 11:57:51 INFO - 'SHELL': '/bin/bash', 11:57:51 INFO - 'SHLVL': '1', 11:57:51 INFO - 'TERM': 'linux', 11:57:51 INFO - 'TMOUT': '86400', 11:57:51 INFO - 'USER': 'cltbld', 11:57:51 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1506538647.591657-324272956', 11:57:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:57:51 INFO - '_': '/tools/buildbot/bin/python'} 11:57:53 INFO - Ignoring indexes: http://pypi.python.org/simple/ 11:57:53 INFO - Downloading/unpacking pip>=1.5 11:57:53 INFO - Running setup.py egg_info for package pip 11:57:53 INFO - warning: no files found matching 'pip/cacert.pem' 11:57:53 INFO - warning: no files found matching '*.html' under directory 'docs' 11:57:53 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 11:57:53 INFO - no previously-included directories found matching 'docs/_build/_sources' 11:57:53 INFO - Installing collected packages: pip 11:57:53 INFO - Found existing installation: pip 1.1 11:57:53 INFO - Uninstalling pip: 11:57:53 INFO - Successfully uninstalled pip 11:57:53 INFO - Running setup.py install for pip 11:57:53 INFO - warning: no files found matching 'pip/cacert.pem' 11:57:53 INFO - warning: no files found matching '*.html' under directory 'docs' 11:57:53 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 11:57:53 INFO - no previously-included directories found matching 'docs/_build/_sources' 11:57:53 INFO - Installing pip script to /builds/slave/test/build/venv/bin 11:57:53 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 11:57:53 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 11:57:53 INFO - Successfully installed pip 11:57:53 INFO - Cleaning up... 11:57:53 INFO - Return code: 0 11:57:53 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:57:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:57:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:57:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:57:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:57:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e0d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fd5b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x217a9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2177d60>, '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 0x2178a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2178ef0>, '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': 'ba164b0a7b0ec7655860e956000001c1-1506538647.591657-324272956', '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 11:57:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 11:57:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 11:57:53 INFO - Using env: {'DISPLAY': ':0', 11:57:53 INFO - 'HOME': '/home/cltbld', 11:57:53 INFO - 'LANG': 'en_US.UTF-8', 11:57:53 INFO - 'LANGUAGE': 'en_US:en', 11:57:53 INFO - 'LOGNAME': 'cltbld', 11:57:53 INFO - 'MAIL': '/var/mail/cltbld', 11:57:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:57:53 INFO - 'MOZ_NO_REMOTE': '1', 11:57:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:57:53 INFO - 'NO_EM_RESTART': '1', 11:57:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:57:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:57:53 INFO - 'PWD': '/builds/slave/test', 11:57:53 INFO - 'SHELL': '/bin/bash', 11:57:53 INFO - 'SHLVL': '1', 11:57:53 INFO - 'TERM': 'linux', 11:57:53 INFO - 'TMOUT': '86400', 11:57:53 INFO - 'USER': 'cltbld', 11:57:53 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1506538647.591657-324272956', 11:57:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:57:53 INFO - '_': '/tools/buildbot/bin/python'} 11:57:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:57:53 INFO - Downloading/unpacking psutil>=3.1.1 11:57:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:57:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:57:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:57:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:57:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:57:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:57:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:57:54 INFO - Installing collected packages: psutil 11:57:54 INFO - Running setup.py install for psutil 11:57:54 INFO - building 'psutil._psutil_linux' extension 11:57:54 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 11:57:54 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 11:57:54 INFO - building 'psutil._psutil_posix' extension 11:57:54 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 11:57:54 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 11:57:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:57:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:57:55 INFO - Successfully installed psutil 11:57:55 INFO - Cleaning up... 11:57:57 INFO - Return code: 0 11:57:57 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:57:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:57:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:57:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:57:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:57:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e0d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fd5b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x217a9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2177d60>, '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 0x2178a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2178ef0>, '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': 'ba164b0a7b0ec7655860e956000001c1-1506538647.591657-324272956', '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 11:57:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 11:57:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 11:57:57 INFO - Using env: {'DISPLAY': ':0', 11:57:57 INFO - 'HOME': '/home/cltbld', 11:57:57 INFO - 'LANG': 'en_US.UTF-8', 11:57:57 INFO - 'LANGUAGE': 'en_US:en', 11:57:57 INFO - 'LOGNAME': 'cltbld', 11:57:57 INFO - 'MAIL': '/var/mail/cltbld', 11:57:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:57:57 INFO - 'MOZ_NO_REMOTE': '1', 11:57:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:57:57 INFO - 'NO_EM_RESTART': '1', 11:57:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:57:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:57:57 INFO - 'PWD': '/builds/slave/test', 11:57:57 INFO - 'SHELL': '/bin/bash', 11:57:57 INFO - 'SHLVL': '1', 11:57:57 INFO - 'TERM': 'linux', 11:57:57 INFO - 'TMOUT': '86400', 11:57:57 INFO - 'USER': 'cltbld', 11:57:57 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1506538647.591657-324272956', 11:57:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:57:57 INFO - '_': '/tools/buildbot/bin/python'} 11:57:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:57:57 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:57:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:57:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:57:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:57:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:57:58 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:57:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:57:58 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:57:58 INFO - Installing collected packages: mozsystemmonitor 11:57:58 INFO - Running setup.py install for mozsystemmonitor 11:57:58 INFO - Successfully installed mozsystemmonitor 11:57:58 INFO - Cleaning up... 11:58:00 INFO - Return code: 0 11:58:00 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:58:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:58:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:58:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:58:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:58:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1e0d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fd5b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x217a9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2177d60>, '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 0x2178a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2178ef0>, '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': 'ba164b0a7b0ec7655860e956000001c1-1506538647.591657-324272956', '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 11:58:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 11:58:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 11:58:00 INFO - Using env: {'DISPLAY': ':0', 11:58:00 INFO - 'HOME': '/home/cltbld', 11:58:00 INFO - 'LANG': 'en_US.UTF-8', 11:58:00 INFO - 'LANGUAGE': 'en_US:en', 11:58:00 INFO - 'LOGNAME': 'cltbld', 11:58:00 INFO - 'MAIL': '/var/mail/cltbld', 11:58:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:58:00 INFO - 'MOZ_NO_REMOTE': '1', 11:58:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:58:00 INFO - 'NO_EM_RESTART': '1', 11:58:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:58:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:58:00 INFO - 'PWD': '/builds/slave/test', 11:58:00 INFO - 'SHELL': '/bin/bash', 11:58:00 INFO - 'SHLVL': '1', 11:58:00 INFO - 'TERM': 'linux', 11:58:00 INFO - 'TMOUT': '86400', 11:58:00 INFO - 'USER': 'cltbld', 11:58:00 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1506538647.591657-324272956', 11:58:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:58:00 INFO - '_': '/tools/buildbot/bin/python'} 11:58:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:58:02 INFO - Downloading/unpacking jsonschema==2.5.1 11:58: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 11:58: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 11:58: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 11:58: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 11:58:03 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:58:03 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:58:03 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 11:58:03 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 11:58:03 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 11:58:03 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 11:58:03 INFO - Downloading functools32-3.2.3-2.tar.gz 11:58:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:58:04 INFO - warning: no files found matching '*.txt' 11:58:04 INFO - no previously-included directories found matching 'build' 11:58:04 INFO - no previously-included directories found matching 'dist' 11:58:04 INFO - no previously-included directories found matching '.git*' 11:58:04 INFO - Installing collected packages: jsonschema, functools32 11:58:04 INFO - Running setup.py install for functools32 11:58:04 INFO - warning: no files found matching '*.txt' 11:58:04 INFO - no previously-included directories found matching 'build' 11:58:04 INFO - no previously-included directories found matching 'dist' 11:58:04 INFO - no previously-included directories found matching '.git*' 11:58:04 INFO - Successfully installed jsonschema functools32 11:58:04 INFO - Cleaning up... 11:58:04 INFO - Return code: 0 11:58:04 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 11:58: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')]} 11:58:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:58: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')]} 11:58:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:58: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 0x1e0d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fd5b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x217a9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2177d60>, '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 0x2178a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2178ef0>, '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': 'ba164b0a7b0ec7655860e956000001c1-1506538647.591657-324272956', '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 11:58: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 11:58: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 11:58:04 INFO - Using env: {'DISPLAY': ':0', 11:58:04 INFO - 'HOME': '/home/cltbld', 11:58:04 INFO - 'LANG': 'en_US.UTF-8', 11:58:04 INFO - 'LANGUAGE': 'en_US:en', 11:58:04 INFO - 'LOGNAME': 'cltbld', 11:58:04 INFO - 'MAIL': '/var/mail/cltbld', 11:58:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:58:04 INFO - 'MOZ_NO_REMOTE': '1', 11:58:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:58:04 INFO - 'NO_EM_RESTART': '1', 11:58:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:58:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:58:04 INFO - 'PWD': '/builds/slave/test', 11:58:04 INFO - 'SHELL': '/bin/bash', 11:58:04 INFO - 'SHLVL': '1', 11:58:04 INFO - 'TERM': 'linux', 11:58:04 INFO - 'TMOUT': '86400', 11:58:04 INFO - 'USER': 'cltbld', 11:58:04 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1506538647.591657-324272956', 11:58:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:58:04 INFO - '_': '/tools/buildbot/bin/python'} 11:58:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:58:04 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 11:58:04 INFO - Cleaning up... 11:58:04 INFO - Return code: 0 11:58:04 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:58: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')]} 11:58:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:58: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')]} 11:58:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:58: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 0x1e0d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fd5b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x217a9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2177d60>, '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 0x2178a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2178ef0>, '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': 'ba164b0a7b0ec7655860e956000001c1-1506538647.591657-324272956', '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 11:58: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 11:58: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 11:58:04 INFO - Using env: {'DISPLAY': ':0', 11:58:04 INFO - 'HOME': '/home/cltbld', 11:58:04 INFO - 'LANG': 'en_US.UTF-8', 11:58:04 INFO - 'LANGUAGE': 'en_US:en', 11:58:04 INFO - 'LOGNAME': 'cltbld', 11:58:04 INFO - 'MAIL': '/var/mail/cltbld', 11:58:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:58:04 INFO - 'MOZ_NO_REMOTE': '1', 11:58:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:58:04 INFO - 'NO_EM_RESTART': '1', 11:58:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:58:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:58:04 INFO - 'PWD': '/builds/slave/test', 11:58:04 INFO - 'SHELL': '/bin/bash', 11:58:04 INFO - 'SHLVL': '1', 11:58:04 INFO - 'TERM': 'linux', 11:58:04 INFO - 'TMOUT': '86400', 11:58:04 INFO - 'USER': 'cltbld', 11:58:04 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1506538647.591657-324272956', 11:58:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:58:04 INFO - '_': '/tools/buildbot/bin/python'} 11:58:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:58:04 INFO - Downloading/unpacking blobuploader==1.2.4 11:58: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 11:58: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 11:58: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 11:58: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 11:58:05 INFO - Downloading blobuploader-1.2.4.tar.gz 11:58:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:58:05 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:58:05 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 11:58:05 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 11:58:05 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 11:58:05 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 11:58:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:58:06 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:58: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 11:58: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 11:58: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 11:58: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 11:58:06 INFO - Downloading docopt-0.6.1.tar.gz 11:58:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:58:06 INFO - Installing collected packages: blobuploader, requests, docopt 11:58:06 INFO - Running setup.py install for blobuploader 11:58:06 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:58:06 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:58:06 INFO - Running setup.py install for requests 11:58:06 INFO - Running setup.py install for docopt 11:58:06 INFO - Successfully installed blobuploader requests docopt 11:58:06 INFO - Cleaning up... 11:58:06 INFO - Return code: 0 11:58:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:58:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:58:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:58:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:58:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:58:06 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 0x1e0d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fd5b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x217a9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2177d60>, '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 0x2178a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2178ef0>, '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': 'ba164b0a7b0ec7655860e956000001c1-1506538647.591657-324272956', '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 11:58:06 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 11:58:06 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 11:58:06 INFO - Using env: {'DISPLAY': ':0', 11:58:06 INFO - 'HOME': '/home/cltbld', 11:58:06 INFO - 'LANG': 'en_US.UTF-8', 11:58:06 INFO - 'LANGUAGE': 'en_US:en', 11:58:06 INFO - 'LOGNAME': 'cltbld', 11:58:06 INFO - 'MAIL': '/var/mail/cltbld', 11:58:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:58:06 INFO - 'MOZ_NO_REMOTE': '1', 11:58:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:58:07 INFO - 'NO_EM_RESTART': '1', 11:58:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:58:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:58:07 INFO - 'PWD': '/builds/slave/test', 11:58:07 INFO - 'SHELL': '/bin/bash', 11:58:07 INFO - 'SHLVL': '1', 11:58:07 INFO - 'TERM': 'linux', 11:58:07 INFO - 'TMOUT': '86400', 11:58:07 INFO - 'USER': 'cltbld', 11:58:07 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1506538647.591657-324272956', 11:58:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:58:07 INFO - '_': '/tools/buildbot/bin/python'} 11:58:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:58:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:58:07 INFO - Running setup.py (path:/tmp/pip-HXiKOB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:58:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:58:07 INFO - Running setup.py (path:/tmp/pip-F_2kMY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:58:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:58:07 INFO - Running setup.py (path:/tmp/pip-DsLJdY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:58:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:58:07 INFO - Running setup.py (path:/tmp/pip-TFHx2L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:58:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:58:07 INFO - Running setup.py (path:/tmp/pip-isc4AH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:58:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:58:07 INFO - Running setup.py (path:/tmp/pip-0cfrL4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:58:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:58:07 INFO - Running setup.py (path:/tmp/pip-SffrYD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:58:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:58:07 INFO - Running setup.py (path:/tmp/pip-_11Gz_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:58:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:58:07 INFO - Running setup.py (path:/tmp/pip-1SGjZv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:58:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:58:07 INFO - Running setup.py (path:/tmp/pip-zeqa3V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:58:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:58:07 INFO - Running setup.py (path:/tmp/pip-O7b1ob-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:58:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:58:07 INFO - Running setup.py (path:/tmp/pip-wbLS3s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:58:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:58:08 INFO - Running setup.py (path:/tmp/pip-Mivqiq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:58:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:58:08 INFO - Running setup.py (path:/tmp/pip-MDKdUb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:58:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:58:08 INFO - Running setup.py (path:/tmp/pip-Y39HOj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:58:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:58:08 INFO - Running setup.py (path:/tmp/pip-Rp6H2y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:58:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:58:08 INFO - Running setup.py (path:/tmp/pip-zW8bkk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:58:08 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:58:08 INFO - Running setup.py install for manifestparser 11:58:08 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:58:08 INFO - Running setup.py install for mozcrash 11:58:08 INFO - Running setup.py install for mozdebug 11:58:08 INFO - Running setup.py install for mozdevice 11:58:08 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:58:08 INFO - Running setup.py install for mozfile 11:58:08 INFO - Running setup.py install for mozhttpd 11:58:08 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:58:08 INFO - Running setup.py install for mozinfo 11:58:09 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:58:09 INFO - Running setup.py install for mozInstall 11:58:09 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:58:09 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:58:09 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:58:09 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:58:09 INFO - Running setup.py install for mozleak 11:58:09 INFO - Running setup.py install for mozlog 11:58:09 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:58:09 INFO - Running setup.py install for moznetwork 11:58:09 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:58:09 INFO - Running setup.py install for mozprocess 11:58:09 INFO - Running setup.py install for mozprofile 11:58:09 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:58:09 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:58:09 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:58:09 INFO - Running setup.py install for mozrunner 11:58:09 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:58:09 INFO - Running setup.py install for mozscreenshot 11:58:09 INFO - Running setup.py install for moztest 11:58:10 INFO - Running setup.py install for mozversion 11:58:10 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:58:10 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:58:10 INFO - Cleaning up... 11:58:10 INFO - Return code: 0 11:58:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:58: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')]} 11:58:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:58: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')]} 11:58:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:58: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 0x1e0d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fd5b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x217a9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2177d60>, '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 0x2178a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2178ef0>, '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': 'ba164b0a7b0ec7655860e956000001c1-1506538647.591657-324272956', '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 11:58: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 11:58: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 11:58:10 INFO - Using env: {'DISPLAY': ':0', 11:58:10 INFO - 'HOME': '/home/cltbld', 11:58:10 INFO - 'LANG': 'en_US.UTF-8', 11:58:10 INFO - 'LANGUAGE': 'en_US:en', 11:58:10 INFO - 'LOGNAME': 'cltbld', 11:58:10 INFO - 'MAIL': '/var/mail/cltbld', 11:58:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:58:10 INFO - 'MOZ_NO_REMOTE': '1', 11:58:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:58:10 INFO - 'NO_EM_RESTART': '1', 11:58:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:58:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:58:10 INFO - 'PWD': '/builds/slave/test', 11:58:10 INFO - 'SHELL': '/bin/bash', 11:58:10 INFO - 'SHLVL': '1', 11:58:10 INFO - 'TERM': 'linux', 11:58:10 INFO - 'TMOUT': '86400', 11:58:10 INFO - 'USER': 'cltbld', 11:58:10 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1506538647.591657-324272956', 11:58:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:58:10 INFO - '_': '/tools/buildbot/bin/python'} 11:58:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:58:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:58:10 INFO - Running setup.py (path:/tmp/pip-EX1Nrm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:58: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)) 11:58:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:58:10 INFO - Running setup.py (path:/tmp/pip-4opy5e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:58: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)) 11:58:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:58:10 INFO - Running setup.py (path:/tmp/pip-38_mfv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:58: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)) 11:58:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:58:10 INFO - Running setup.py (path:/tmp/pip-u5CSUy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:58: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)) 11:58:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:58:10 INFO - Running setup.py (path:/tmp/pip-9HdwqY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:58:10 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)) 11:58:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:58:10 INFO - Running setup.py (path:/tmp/pip-RG0Uke-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:58:10 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)) 11:58:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:58:10 INFO - Running setup.py (path:/tmp/pip-ceyn4o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:58:10 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)) 11:58:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:58:10 INFO - Running setup.py (path:/tmp/pip-c1FAvr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:58:10 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)) 11:58:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:58:10 INFO - Running setup.py (path:/tmp/pip-VjhZPa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:58: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)) 11:58:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:58:11 INFO - Running setup.py (path:/tmp/pip-u0vYp4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:58: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)) 11:58:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:58:11 INFO - Running setup.py (path:/tmp/pip-0N14Vy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:58: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)) 11:58:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:58:11 INFO - Running setup.py (path:/tmp/pip-2ZIxsI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:58: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)) 11:58:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:58:11 INFO - Running setup.py (path:/tmp/pip-MAZ3Bi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:58: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)) 11:58:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:58:11 INFO - Running setup.py (path:/tmp/pip-NchSdB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:58: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)) 11:58:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:58:11 INFO - Running setup.py (path:/tmp/pip-kaHmbO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:58: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)) 11:58:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:58:11 INFO - Running setup.py (path:/tmp/pip-e7b4bW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:58: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)) 11:58:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:58:11 INFO - Running setup.py (path:/tmp/pip-Ocpmoz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:58: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)) 11:58: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)) 11:58: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)) 11:58: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)) 11:58: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)) 11:58: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)) 11:58: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)) 11:58:11 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:58: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 11:58: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 11:58: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 11:58: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 11:58:12 INFO - Downloading blessings-1.6.tar.gz 11:58:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:58:12 INFO - Installing collected packages: blessings 11:58:12 INFO - Running setup.py install for blessings 11:58:12 INFO - Successfully installed blessings 11:58:12 INFO - Cleaning up... 11:58:12 INFO - Return code: 0 11:58:12 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:58:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:58:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:58:13 INFO - Reading from file tmpfile_stdout 11:58:13 INFO - Current package versions: 11:58:13 INFO - argparse == 1.2.1 11:58:13 INFO - blessings == 1.6 11:58:13 INFO - blobuploader == 1.2.4 11:58:13 INFO - docopt == 0.6.1 11:58:13 INFO - functools32 == 3.2.3-2 11:58:13 INFO - jsonschema == 2.5.1 11:58:13 INFO - manifestparser == 1.1 11:58:13 INFO - mozInstall == 1.13 11:58:13 INFO - mozcrash == 1.0 11:58:13 INFO - mozdebug == 0.1 11:58:13 INFO - mozdevice == 0.51 11:58:13 INFO - mozfile == 1.2 11:58:13 INFO - mozhttpd == 0.7 11:58:13 INFO - mozinfo == 0.10 11:58:13 INFO - mozleak == 0.1 11:58:13 INFO - mozlog == 3.5 11:58:13 INFO - moznetwork == 0.27 11:58:13 INFO - mozprocess == 0.25 11:58:13 INFO - mozprofile == 0.28 11:58:13 INFO - mozrunner == 6.13 11:58:13 INFO - mozscreenshot == 0.1 11:58:13 INFO - mozsystemmonitor == 0.3 11:58:13 INFO - moztest == 0.8 11:58:13 INFO - mozversion == 1.4 11:58:13 INFO - psutil == 3.1.1 11:58:13 INFO - requests == 1.2.3 11:58:13 INFO - wsgiref == 0.1.2 11:58:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:58: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')]} 11:58:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:58: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')]} 11:58:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:58: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 0x1e0d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fd5b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x217a9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2177d60>, '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 0x2178a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2178ef0>, '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': 'ba164b0a7b0ec7655860e956000001c1-1506538647.591657-324272956', '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 11:58: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 11:58: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 11:58:13 INFO - Using env: {'DISPLAY': ':0', 11:58:13 INFO - 'HOME': '/home/cltbld', 11:58:13 INFO - 'LANG': 'en_US.UTF-8', 11:58:13 INFO - 'LANGUAGE': 'en_US:en', 11:58:13 INFO - 'LOGNAME': 'cltbld', 11:58:13 INFO - 'MAIL': '/var/mail/cltbld', 11:58:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:58:13 INFO - 'MOZ_NO_REMOTE': '1', 11:58:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:58:13 INFO - 'NO_EM_RESTART': '1', 11:58:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:58:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:58:13 INFO - 'PWD': '/builds/slave/test', 11:58:13 INFO - 'SHELL': '/bin/bash', 11:58:13 INFO - 'SHLVL': '1', 11:58:13 INFO - 'TERM': 'linux', 11:58:13 INFO - 'TMOUT': '86400', 11:58:13 INFO - 'USER': 'cltbld', 11:58:13 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1506538647.591657-324272956', 11:58:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:58:13 INFO - '_': '/tools/buildbot/bin/python'} 11:58:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:58: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)) 11:58: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)) 11:58: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)) 11:58: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)) 11:58: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)) 11:58: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)) 11:58: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)) 11:58: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)) 11:58: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)) 11:58:13 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 11:58: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 11:58: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 11:58: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 11:58: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 11:58:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 11:58: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)) 11:58: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)) 11:58:14 INFO - Installing collected packages: simplejson 11:58:14 INFO - Running setup.py install for simplejson 11:58:14 INFO - building 'simplejson._speedups' extension 11:58: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 11:58: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 11:58:15 INFO - Successfully installed simplejson 11:58:15 INFO - Cleaning up... 11:58:15 INFO - Return code: 0 11:58:15 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:58: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')]} 11:58:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:58: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')]} 11:58:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:58: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 0x1e0d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fd5b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x217a9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2177d60>, '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 0x2178a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2178ef0>, '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': 'ba164b0a7b0ec7655860e956000001c1-1506538647.591657-324272956', '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 11:58: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 11:58: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 11:58:15 INFO - Using env: {'DISPLAY': ':0', 11:58:15 INFO - 'HOME': '/home/cltbld', 11:58:15 INFO - 'LANG': 'en_US.UTF-8', 11:58:15 INFO - 'LANGUAGE': 'en_US:en', 11:58:15 INFO - 'LOGNAME': 'cltbld', 11:58:15 INFO - 'MAIL': '/var/mail/cltbld', 11:58:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:58:15 INFO - 'MOZ_NO_REMOTE': '1', 11:58:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:58:15 INFO - 'NO_EM_RESTART': '1', 11:58:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:58:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:58:15 INFO - 'PWD': '/builds/slave/test', 11:58:15 INFO - 'SHELL': '/bin/bash', 11:58:15 INFO - 'SHLVL': '1', 11:58:15 INFO - 'TERM': 'linux', 11:58:15 INFO - 'TMOUT': '86400', 11:58:15 INFO - 'USER': 'cltbld', 11:58:15 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1506538647.591657-324272956', 11:58:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:58:15 INFO - '_': '/tools/buildbot/bin/python'} 11:58:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:58:15 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:58:15 INFO - Cleaning up... 11:58:15 INFO - Return code: 0 11:58:15 INFO - Running post-action listener: _resource_record_post_action 11:58:15 INFO - Running post-action listener: _start_resource_monitoring 11:58:15 INFO - Starting resource monitoring. 11:58:15 INFO - [mozharness: 2017-09-27 18:58:15.919677Z] Finished create-virtualenv step (success) 11:58:15 INFO - [mozharness: 2017-09-27 18:58:15.920153Z] Running install step. 11:58:15 INFO - Running pre-action listener: _resource_record_pre_action 11:58:15 INFO - Running main action method: install 11:58:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:58:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:58:16 INFO - Reading from file tmpfile_stdout 11:58:16 INFO - Detecting whether we're running mozinstall >=1.0... 11:58:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:58:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:58:16 INFO - Reading from file tmpfile_stdout 11:58:16 INFO - Output received: 11:58:16 INFO - Usage: mozinstall [options] installer 11:58:16 INFO - Options: 11:58:16 INFO - -h, --help show this help message and exit 11:58:16 INFO - -d DEST, --destination=DEST 11:58:16 INFO - Directory to install application into. [default: 11:58:16 INFO - "/builds/slave/test"] 11:58:16 INFO - --app=APP Application being installed. [default: firefox] 11:58:16 INFO - mkdir: /builds/slave/test/build/application 11:58: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'] 11:58:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 11:58:33 INFO - Reading from file tmpfile_stdout 11:58:33 INFO - Output received: 11:58:33 INFO - /builds/slave/test/build/application/firefox/firefox 11:58:33 INFO - Running post-action listener: _resource_record_post_action 11:58:33 INFO - [mozharness: 2017-09-27 18:58:33.918393Z] Finished install step (success) 11:58:33 INFO - [mozharness: 2017-09-27 18:58:33.918538Z] Running setup-mitmproxy step. 11:58:33 INFO - Running pre-action listener: _resource_record_pre_action 11:58:33 INFO - Running main action method: setup_mitmproxy 11:58:33 INFO - Skipping: mitmproxy is not required 11:58:33 INFO - Running post-action listener: _resource_record_post_action 11:58:33 INFO - [mozharness: 2017-09-27 18:58:33.919070Z] Finished setup-mitmproxy step (success) 11:58:33 INFO - [mozharness: 2017-09-27 18:58:33.919173Z] Running run-tests step. 11:58:33 INFO - Running pre-action listener: _resource_record_pre_action 11:58:33 INFO - Running pre-action listener: _set_gcov_prefix 11:58:33 INFO - Running main action method: run_tests 11:58:33 WARNING - Try message not found. 11:58:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:58:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:58:33 INFO - Python 2.7.3 11:58:33 INFO - Return code: 0 11:58:33 INFO - grabbing minidump binary from tooltool 11:58:33 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')]} 11:58:33 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 0x2177d60>, '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 0x2178a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2178ef0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:58:33 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 11:58:33 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 11:58:33 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 11:58:33 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:58:34 INFO - Return code: 0 11:58:34 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:58:34 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:58:34 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:58:34 INFO - ENV: RUST_BACKTRACE is now full 11:58:34 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:58:34 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:58:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-stylo-disabled-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/PBHu4AnVT_OJapiiUJnugg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-029', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log'] in /builds/slave/test/build 11:58:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-stylo-disabled-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/PBHu4AnVT_OJapiiUJnugg/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-029 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log 11:58:34 INFO - Using env: {'DISPLAY': ':0', 11:58:34 INFO - 'HOME': '/home/cltbld', 11:58:34 INFO - 'LANG': 'en_US.UTF-8', 11:58:34 INFO - 'LANGUAGE': 'en_US:en', 11:58:34 INFO - 'LOGNAME': 'cltbld', 11:58:34 INFO - 'MAIL': '/var/mail/cltbld', 11:58:34 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:58:34 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:58:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:58:34 INFO - 'MOZ_NO_REMOTE': '1', 11:58:34 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:58:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:58:34 INFO - 'NO_EM_RESTART': '1', 11:58:34 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:58:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:58:34 INFO - 'PWD': '/builds/slave/test', 11:58:34 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:58:34 INFO - 'RUST_BACKTRACE': 'full', 11:58:34 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 11:58:34 INFO - 'SHELL': '/bin/bash', 11:58:34 INFO - 'SHLVL': '1', 11:58:34 INFO - 'TERM': 'linux', 11:58:34 INFO - 'TMOUT': '86400', 11:58:34 INFO - 'USER': 'cltbld', 11:58:34 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1506538647.591657-324272956', 11:58:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:58:34 INFO - '_': '/tools/buildbot/bin/python'} 11:58:34 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-stylo-disabled-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/PBHu4AnVT_OJapiiUJnugg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-029', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log'] with output_timeout 3600 11:58:34 INFO - mozversion application_buildid: 20170927173830 11:58:34 INFO - mozversion application_changeset: 756e10aa8bbd416cbc49b7739f78fb81d5525477 11:58:34 INFO - mozversion application_display_name: Nightly 11:58:34 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:58:34 INFO - mozversion application_name: Firefox 11:58:34 INFO - mozversion application_remotingname: firefox 11:58:34 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 11:58:34 INFO - mozversion application_vendor: Mozilla 11:58:34 INFO - mozversion application_version: 58.0a1 11:58:34 INFO - mozversion platform_buildid: 20170927173830 11:58:34 INFO - mozversion platform_changeset: 756e10aa8bbd416cbc49b7739f78fb81d5525477 11:58:34 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 11:58:34 INFO - mozversion platform_version: 58.0a1 11:58:34 INFO - using testdate: 1506538714 11:58:34 INFO - actual date: 1506538714 11:58:34 INFO - starting webserver on 'localhost:59720' 11:58:34 INFO - SUITE-START | Running 2 tests 11:58:34 INFO - TEST-START | dromaeo_css 11:58:34 INFO - Initialising browser for dromaeo_css test... 11:58:34 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:59720/getInfo.html -profile /tmp/tmp57Iy9M/profile 11:58:34 INFO - TEST-INFO | started process 17687 (/builds/slave/test/build/application/firefox/firefox http://localhost:59720/getInfo.html) 11:58:40 INFO - TEST-INFO | 17687: exit 0 11:58:40 INFO - Browser initialized. 11:58:40 INFO - Running cycle 1/1 for dromaeo_css test... 11:58:40 INFO - Using env: {'DISPLAY': ':0', 11:58:40 INFO - 'HOME': '/home/cltbld', 11:58:40 INFO - 'JSGC_DISABLE_POISONING': '1', 11:58:40 INFO - 'LANG': 'en_US.UTF-8', 11:58:40 INFO - 'LANGUAGE': 'en_US:en', 11:58:40 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 11:58:40 INFO - 'LOGNAME': 'cltbld', 11:58:40 INFO - 'MAIL': '/var/mail/cltbld', 11:58:40 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:58:40 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:58:40 INFO - 'MOZ_CRASHREPORTER': '1', 11:58:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:58:40 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 11:58:40 INFO - 'MOZ_NO_REMOTE': '1', 11:58:40 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:58:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:58:40 INFO - 'NO_EM_RESTART': '1', 11:58:40 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:58:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:58:40 INFO - 'PWD': '/builds/slave/test', 11:58:40 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:58:40 INFO - 'RUST_BACKTRACE': 'full', 11:58:40 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 11:58:40 INFO - 'SHELL': '/bin/bash', 11:58:40 INFO - 'SHLVL': '1', 11:58:40 INFO - 'STYLO_FORCE_DISABLED': '1', 11:58:40 INFO - 'TERM': 'linux', 11:58:40 INFO - 'TMOUT': '86400', 11:58:40 INFO - 'USER': 'cltbld', 11:58:40 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1506538647.591657-324272956', 11:58:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:58:40 INFO - '_': '/tools/buildbot/bin/python'} 11:58:40 INFO - TEST-INFO | started process 17923 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp57Iy9M/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 11:58:41 INFO - PID 17923 | 11:58:41 INFO - PID 17923 | (/builds/slave/test/build/application/firefox/firefox:17973): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 11:58:41 INFO - PID 17923 | 11:58:51 INFO - PID 17923 | RSS: Main: 145145856 11:58:51 INFO - PID 17923 | 12:01:49 INFO - PID 17923 | Cycle 1(1): loaded http://localhost:59720/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59720/tests/dromaeo/cssquery-ext.html) 12:01:50 INFO - PID 17923 | RSS: Main: 145940480 12:01:50 INFO - PID 17923 | 12:04:52 INFO - PID 17923 | Cycle 1(1): loaded http://localhost:59720/tests/dromaeo/cssquery-ext.html (next: http://localhost:59720/tests/dromaeo/cssquery-jquery.html) 12:04:52 INFO - PID 17923 | RSS: Main: 145682432 12:04:52 INFO - PID 17923 | 12:07:54 INFO - PID 17923 | Cycle 1(1): loaded http://localhost:59720/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59720/tests/dromaeo/cssquery-mootools.html) 12:07:55 INFO - PID 17923 | RSS: Main: 148111360 12:07:55 INFO - PID 17923 | 12:10:56 INFO - PID 17923 | Cycle 1(1): loaded http://localhost:59720/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59720/tests/dromaeo/cssquery-prototype.html) 12:10:57 INFO - PID 17923 | RSS: Main: 146354176 12:10:57 INFO - PID 17923 | 12:14:00 INFO - PID 17923 | Cycle 1(1): loaded http://localhost:59720/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59720/tests/dromaeo/cssquery-yui.html) 12:14:01 INFO - PID 17923 | RSS: Main: 147693568 12:14:01 INFO - PID 17923 | 12:17:02 INFO - PID 17923 | Cycle 1(1): loaded http://localhost:59720/tests/dromaeo/cssquery-yui.html (next: http://localhost:59720/tests/dromaeo/cssquery-dojo.html) 12:17:02 INFO - PID 17923 | RSS: Main: 150179840 12:17:02 INFO - PID 17923 | 12:17:02 INFO - PID 17923 | __start_tp_report 12:17:02 INFO - PID 17923 | _x_x_mozilla_page_load 12:17:02 INFO - PID 17923 | _x_x_mozilla_page_load_details 12:17:02 INFO - PID 17923 | |i|pagename|runs| 12:17:02 INFO - PID 17923 | |0;dojo.html;3865.613438656134;3902.9414558781605;3912.74567153135;3915.1973845361704;3921.1373497830486;6220.813375598728;6273;6326.145970294009;6335.841603959903;6428.292887782341;6312.589681670688;6318.020706790443;6321.7155228014735;6326.14597029402;6350.42846143847;5608.130739735328;5658.321001479808;5673.6879471629045;5673.8581535461635;5772.509336706385;5756.884862302752;5774.769009239625;5797.043487824504;5806.477417032466;5837.357890632027;5709.514691251248;5712.200291959129;5726.169705392736;5813.970930145343;5816.185733997244;5502.889942201174;5617.8033768817895;5625.887482250332;5694.857628559278;5716.685582292972;5616.241807355996;5637.63355381903;5728.570357223225;5729.9713501432225;5735.713214339308;6264.248290205159;6269.561130720851;6273.968630156865;6274.1843560336865;6283.120363149163;6873.518853680244;6889.207741109736;6903.689333979983;6965.164180298397;6968.721251149948;6888.621125838077;6918.723251069951;6985.336393042653;6992.3357281058215;6999.650017499104;6314.336994615545;6320;6338.746450141989;6374.075759014963;6406.93593064068;6936.653167341613;6964.129483814523;7041.683124259421;7103.289671032855;7181.4972951893915;6688.3646053624825;6832.043513908056;6857.691403886837;6868.828279292958;6880.552764070319;6874.450043996569;6888.690008949609;6898.344657257653;6984.930150698529;6986.371226589631;6738.966305168541;6830.21452532965;6839.93160068393;6911.965440172767;6931.202911665223;6848.931510684929;6854.108965834509;6889.311068893171;6920.4809639277255;6927.203371612329;4887.462379138292;4938.629602779734;4955.727434991038;4956.330895329084;4970.552650261494;4512.932306015412;4520.638348932078;4527.84152554659;4538.931916021263;4540.704854184468;6351.714172862232;6352.396522330371;6354.237491500957;6366.84082897922;6395.552311338255;6849.315068493111;6855.485838562127;6925.653717314114;6936.271691472322;6936.4797640177185;6213.161223234896;6295.181626388632;6329.556931014785;6370.1718776558755;6384.776532821329;5464.480874316933;5478.397376288605;5566.304211973504;5570.192322113352;5575.637583557056;7198.172210195789;7266.128064632172;7290.4167666586545;7292.781216563511;7303.087114110736;6824.078749368771;6847.041414201916;6864.965675171592;6903.896441553381;6905.723771049102;7065.894011589933;7135.964320178574;7178.964105179441;7179.533330333512;7182.066331376887;6778.661066946732;6799.966000169968;6805.761798337035;6838.452923766186;6856.657167141722;6815.284395138439;6851.588904665736;6883.931160688329;6928.099347084847;6932.618705971018;6609.140811694641;6649.767258145942;6718;6751.3248675134055;6755.864882702417;6627.834304142435;6691.197056353269;6722;6723.361280678328;6723.966380168068;6460.676966151767;6505.154329937267;6516.5112616553;6608.041833934149;6608.306127856506;6580.374864387875;6632;6696.966515167393;6703.765368212089;6710.396064354231;6451.258105317761;6520.771772988112;6521.347865213441;6535.183102112236;6550.312217217123 12:17:02 INFO - PID 17923 | |1;ext.html;933.6638810028393;962.6486332488644;994.8905620381756;996.8355221388472;1018.8064267789124;43554.34668479971;44007.339889901676;44104.77947610257;44496.55503444961;44544.3318350225;40747.185056298855;40987.385189222114;41034.7948260259;41229.7938510307;41230.58769412305;7385.778426647209;7443.665035073408;7447.143578488489;7510.324070833624;7548.471606987513;7447.739329123455;7499.175090740015;7530.246975302481;7531.3221810037085;7536.773896783106;8369.790755231106;8569.485830850137;8577.39958202926;8577.785555361135;8578.485290882536;8450.704225352114;8452.535110568917;8504.74485765422;8513.787155321104;8525.062243153248;8230.588470576447;8357.958210208972;8362.247397734172;8368.916310836936;8378.12029736881;39788.403173952414;40311;40321.59678403208;40537.391939120644;40543.79728101341;3753.380692185786;3786.9621303786885;3799.1831756172555;3811.5616704079107;3816.5610954740005;33101.834490827634;33134;33139;33175;33188.668113318796;5494.314081668185;5502.119660854244;5504.394516603171;5535.557155427556;5591.832245032656;217866;218011;218742.90628546916;219701;220380;52917;53180;53448.19827702588;53524;53529;55758;55783.72108139433;55860;55963.44036559664;56160;16171.43399980995;16533.83466165347;16562.089085100437;16575.336986520404;16608.16959152062;13242.139260948008;13406.798898016537;13445;13445;13463;15172.393104275927;15378.615534611501;15480.5355839325;15591.610209744847;15682.921585392;6293.2762732285455;6328.6835658216905;6412.454941330039;6443.581167224115;6480;1084.311462221495;1096.9286996345213;1103.6578660615235;1111.0278506306981;1117.5976648406568;24084.27747167588;24226;24274;24412.657303848104;24497.510049798904;1180.2800291821982;1196.4077781498213;1201.963941081769;1211.3277131192274;1224.161449407159;12955.5465558705;13043.543475978486;13138.802917956238;13304.401301941436;13361.331933403291;283180;283300;283536;283647;283821;56519.71740141273;61864.69067654633;62973.37026629675;63646.36353636404;63703;1486.8661820436212;1533.877289816812;1536.093704714224;1539.3073117097126;1543.3517922472588;29600;29600.259993499472;29990.70009299879;30144.69855301419;30396.84801575978;40990.590094098676;41194;41220.1755964885;41343;41380.1723965513;231497;231784;231845;232694;233201;34507.827460862536;34611.48082778811;34633.1341716449;34641.30717385588;34698.959031229104;44125;44176.77911610421;44593.55406445894;45147.774261128485;45228.547714522436;32951.340973179926;33405.83297083499;33416.49875251922;33530;33542.66457335493;34139.31721365509;34408.65591344055;34688.65311346854;34804.82597586996;34981;39149.41275880921;39529.604703952595;39923.80038099791;40132;40250.59749402468;32870.835645821615;32880;33139.50290745689;33193.17017074592;33532.49701254532;24351.51296974086;24461.143859964817;24602.956393938843;24920.875395622905;25040.37399065038 12:17:02 INFO - PID 17923 | |2;jquery.html;615.3600255734037;631.151101768122;634.5019159959432;638.5306799502367;643.9195100612424;23450.413739656517;23750.524989500198;24234;24328;24365.999999999978;24880.50238995219;25990.870045649746;26032.34919127018;26047.088351907638;26070.08754693586;6430.131932189153;6584.506162037842;6592.077109204715;6593.3736295051895;6604.636744979024;6351.491880649537;6562.179727534059;6598.93401065988;6602;6603;6580.835479113012;6585.308542603029;6585.604863708193;6588.538802283842;6592.044153597725;6535.281119076922;6563.343665633446;6565.474762019075;6567.671616419184;6569;6081.148639190517;6122.571420000601;6145.8156255312415;6159.568830181889;6163.476104531121;28636.713632863823;29430;30221.697783022108;30322;30385.544216836766;2291.873946932918;2333.230034088747;2334.9182778602667;2335;2335.7313908900355;19930.402087937386;20488.078036488245;20569.382918512467;20599;20631.896840515703;2457.9877100614563;2513.0576033987254;2530.8481491110592;2555.3611597100726;2566.0762125634756;133397.33301333527;140643.29678351645;148768.2561587196;154321.22839385844;155323;15952.92023539875;16098.275577599035;16229.188540572924;16309.83690163107;17045.659086818196;26313.473730525282;26386;26580.734192657826;26587.734122658527;26604.201873943814;9925.950370248247;10119.7470063249;10127.291089623655;10198.133158681447;10421.322614030063;8985;9060.229880460103;9196.632134714537;9199.678011269574;9298.070192980784;9456.243500519942;9672.56473458696;9738.101070291366;9961.505774133939;9995.70012899614;2860.613817134702;2884.97115028847;2911.097559756482;2926.1221633510286;2967.2285205846206;1044.5247412427327;1047.298310132198;1052.1214785654065;1064.5422468338534;1079.1582565598846;20682.482937926372;20769.792302077087;20935.58128837445;21207.8939605301;21304.573908522052;1120.9327440353604;1129.1023636209234;1129.4522156753967;1138.698244965085;1139.5441823270592;11468.13988950832;11669.766604667859;11714.472848721827;11741.647750567327;11767.411629418495;614254;621986;638597;642504;646907;127836;129667;132231.33884330516;132738.33630831784;135213;1087.7280679830042;1124.8706398764084;1170.2744298534792;1172.3083380805365;1231.8275441438207;21501.46246343854;22366;22383.552328953654;22445;22539.32382028542;60917.39082609117;62568.06147907876;63621.68189159025;63688;64975.67512162409;77414.612926935;78090;78829.60585197038;78886;78897.8165327532;15429.151396673291;15792.60518487047;15971.121588312755;15984.440544580884;15992.600184995468;23804.761952380253;23876.880615596812;24105.75894241035;24291.39271518226;24319.756802432457;19719.901400492905;19750.209991600175;19849.603007939473;19921.701174482685;20076.698849516975;17531.474055778348;17584.38454654132;18020.819791801914;18267.53859691248;18443.907780461013;19763.209471620976;19967.60064798725;19982;20105.29631462892;20120.99395030272;15617.609559761097;15673.68652626964;15678.764818527503;15689.450869219523;15710.9214453927;19218;19225.230990760214;19405.514862127995;19411.902940485208;19587.118579663664 12:17:02 INFO - PID 17923 | |3;mootools.html;1408.598549413417;1456.1990905002253;1475.4467074846932;1484.5768955847582;1485.0718301061836;17246.91376543117;17942.91028544857;17948.910255448736;17973;17987.82012179881;17260.22328995195;17802.109894505254;17834.375796847115;17845.464636060908;17858.732119018227;2815.1413818785263;2868.8709008094684;2875.151830210093;2884.408696217281;2888.335682792959;2646.894124235038;2678.2500899748006;2679.8124131310815;2683.168217852462;2749.8212616179985;2796.258991367289;2848.6581610206804;2849.3019210293505;2851.073401144626;2851.3726980064457;2670.612761149632;2712.050782226225;2712.403271280315;2712.715164907676;2712.823666461674;2670.919872403831;2691.0581296546247;2692.0846912049997;2695.17797071893;2697.527932611785;16273.186340683036;16645.084520351375;16698.749518757228;16709.498715038568;16720;8334.874976875351;8548.187922147386;8621.741347759576;8644.610992505352;8647.610857511427;5409.675419474844;5617.129344951539;5703.572232082611;5733.77064917407;5772.855678608026;2085.1971990783504;2177.738671359431;2189.5949249388914;2221.7222847144108;2234.3297010896827;29879.701202987908;30101.69898301011;30208.54687179694;30229.395412091635;30367.848160759277;7105.182903966007;7341.375983041501;7359.521631093961;7507.887381689279;7548.509346892544;19663.901680491505;19667.114979825943;19763.40709778709;19770.11034503422;22515.662265066036;8669.436486628349;8918.063603321687;8922.68770593026;8946.105389461132;8951.060138685474;7878.684852605947;7913.604319783988;8084.3936704747375;8120.3503719702285;8173.713920012771;5957.702114894238;6121.724522396503;6132.233470816148;6184.907226391608;6212.347703491158;1729.2564197394988;1786.2854858056621;1800.468861685806;1803.873728838995;1836.1003108477016;951.8286708392417;959.4930528916681;981.8379967305458;987.2398253344884;990.1534188268927;8182.1817818217705;8193.262606365337;8206.876896846552;8214.671413143407;8304.169583041768;798.9041315042232;802.5626033811586;806.1736719862071;813.1096449387911;824.6660102658433;4759.595434388047;4845.781939812717;4849.224124140121;4880.95119048805;4917.967226882323;24163.63754543683;24693;24821.87589062043;25631.23106306814;25644.48711025769;24341.878290608434;24615;25160.622590661154;25172.24483265505;25301.873490632428;12648.494060237672;12728.936355318165;12818.359082045861;12891.806622900664;12941.741165176643;9197.816043679222;9346.953265233631;9377.202937750368;9381.061893810564;9657.22742180638;20316.28892988738;20502.38492845217;20856.165753369696;21200.257990970244;21376.038078286205;22239.888800555895;22371.552568948857;22381.88809055944;22553.097876084772;22593.548129037656;13490.595282141552;13499.32503374847;13625.114367566077;13656.93171534136;13795.172289662652;15425.305861236047;15562.533124006299;15572.454964076656;15584.766228506354;15588.766168507254;12188.939055304667;12346.197497162655;12462.065345098972;12476.126671132934;12578.874211257771;12147.878521214674;12376.81434778497;12499.812502812283;12641;12735.172213806072;10669.786604267716;10753.89246107529;10783.568657253936;10816.621418250323;10817.891821082003;8363.540005299767;8448.366372521963;8495.575221239036;8565.785855353417;8593.742187734379;8412.453190542596;8437.704680336159;8443.282321002784;8483.787905302417;8583.270422014199 12:17:02 INFO - PID 17923 | |4;prototype.html;557.7434380185114;558.3885645218487;566.1818672018932;585.9326177489585;589.811260396673;5955.642661440311;6155.969220153898;6200.534959878005;6252.437280644741;6271.1847459830215;6156.876862462759;6212.1303017577575;6227.377262273771;6238.313785483593;6279.357972376022;5201.661891977028;5218.478152184789;5226.451222621627;5234.18870075139;5264.394594621629;5151.665141765773;5237.292965449654;5269.841904742864;5286.65636733613;5311.840644780644;5129.563987061104;5200.973995130038;5218.295530103444;5224.85053288276;5278.155495120782;5134.768935397916;5226.712530810785;5268.578513718893;5274.103402421598;5311.167647161723;4985.202367621199;4998.825041123543;4999.550040496373;5007.549320561167;5017.867406352322;6222.502199824004;6309.71606277714;6320.494360451153;6391.296957334689;6398.168238129014;6258.687065646745;6292.4966002719675;6294.874102517924;6308.905366419462;6315.810525684236;6772.322767723237;6804.523683342168;6823.021323816088;6843.486738494633;6852.554583952027;5239.397469291042;5513.594033521466;5557.944420555783;5579.581531385163;5603.187537806995;6877.690503927335;7013.333733295329;7041.542299750551;7071.540349877241;7087.220405755363;5735.598508104393;5738.110592858114;5743.167240750068;5775.797847075332;5777.566682498829;5772.5670574707065;5843.954615884407;5856.832971800461;5868.23712917318;5870.911936320958;6200;6217.533684973645;6254.437100660963;6257.843553911098;6282.905756413657;6747.763828265987;6788.558743681645;6816.488763342769;6822.897656535156;6831.599522097958;2002.6081873098349;2027.807358300959;2028.239410221167;2039.7246371739923;2044.9079791409124;1457.1694134343534;1513.8107736532934;1538.130956009851;1544.4980381375874;1553.2662513975486;6068.4538391544975;6104.9316369635135;6113.786017489367;6297.244330680348;6329.493640508748;6613.4709223262025;6641.966790166115;6716.29478904708;6736.2253340865445;6774.9675097471545;6132.540059495555;6143.170671959318;6204.627722336674;6242.469390101802;6262.342454042351;3484.686378225972;3586.3903136466865;3597.4603809428795;3644;3664.7434679572175;7120.585237152998;7155.391791697764;7174.713011479586;7206.819829504199;7206.819829504304;6957.1651401831095;6999.8600027999155;7011.509194356346;7012.1935977363255;7016;7005.404540614003;7040.718371265092;7086;7093.432525397852;7135.82160445993;6731.865362692816;6769.323067693192;6770.830729231611;6809.684707199576;6835.248122706399;6682.732690692318;6686.632235227109;6689.397954184147;6771.39057484809;6832.658367081725;6958.686859091455;7066.152061752417;7068.71725130989;7179.928200717926;7182.389496892613;5638.971805140948;5687.260656114679;5694.971525142348;5722.885542289214;5782.2483077199695;6539.313372095861;6701.860683683688;6868.347506986828;6907.827304317432;6940.930590694028;6630.9336906630315;6636.104125943129;6638;6692.130023097161;6711.3288671132495;6605.702743376656;6615.338466153538;6656.36764507371;6663.433608143362;6676.126427707703;6593.241777195684;6593.472522198117;6593.736250549924;6595.769148079986;6602.66986650656;6556.18047744032;6605;6729.629870357177;6737.966310168418;6777.322267773183;6538.1500404947055;6545.541812073109;6547.672616369067;6560.737570497317;6567.343265673395 12:17:02 INFO - PID 17923 | |5;yui.html;988.63914671145;996.5981983419957;1004.7488127968008;1025.897410258974;1027.9434631095287;19836.404907852753;20585.27951521697;20901.477463063395;20911.16355345788;20920.26779062733;19514.121864516095;19667.31164409246;19733.70399444006;19764.30824921128;19766.604667906635;1020.8825985011725;1048.1981284317503;1048.4705223861938;1048.4757621189406;1048.4967215736451;1050.4170185547018;1050.679542739464;1050.7320633238514;1051.47951763877;1056.5668076088805;1084.8752393474772;1117.357519426329;1119.5969450997675;1120.8262719278484;1131.2590253384046;1117.4245263689206;1119.3843386137632;1122.6183097746723;1124.2130508643982;1128.266626692648;818.4475479051675;819.1399031017468;820.7948012996751;821.4455242711146;825.7564018614463;19237.80762192374;19367.51581210467;19612;19790.80209197904;19821.603567928705;21276.255331063494;21704.674429883566;22054.779452205432;22068.668969965463;22079.779202207934;18498.44504664849;18638.813611863978;18691.626167476574;18723;18840.34058807949;3860.652541271299;3889.611038896116;3897.688184945226;4081.1429599784083;4086.6322031017353;128581;139936.93118313883;159973;160097;164196.17901910533;18234.544136396697;18287.542811429554;18386.448406547825;18477.445676629453;18521.35175268886;33271.33457330888;34058.318833623685;34203.486947695805;34262.82868585641;34272.657273427445;9124.908750912406;9554.331196816294;9636.807263854684;9649.807003859883;9650.08324209199;4504.842330518416;4601.171789077931;4615.492295847454;4644.164050470948;4675.275332323427;6306.306306306303;6339.683015849189;6343.524235682342;6426.389492998158;6429.517786166056;1216.5766053717173;1220.6216073017392;1223.5228260978226;1230.8830661087181;1246.6447062587301;726.4007194064917;744.6053591596462;745.2547452547452;752.0449029732209;760.2511526146741;13324.267165305808;13359.034026785928;13387.263700496565;13826.65433364174;13867;743.5204293230836;747.3572727454385;753.886916962449;759.5215014540804;761.2919984414548;6517.967410162919;6633.2040155181685;6670.132882725215;6713.26154123046;6762.357576030269;154278.22860885624;159699;159999;160599;161254.1937290306;113592;132093;138009;139589;141180.2940985309;120802.3959880195;121316;122747.3862630699;123376;124169;13771.586852394445;14146.575602731522;14372.137671739729;14401.135931844123;14578.85421145775;52414.47585524096;53859.19211211757;54444;54993.45006550043;55289;70332;70596.29403705898;72182.63908680424;73014.63492682502;73930.2606973945;19196;19480;19568.706469403256;19597.216111355385;19876.304329348404;20506;20523.794762052188;20554.486137846674;20768.273110441063;20862.582748345252;19127.23491060342;19389.806101939364;19448.708269376253;19460.708089378386;19464;20113.899430502755;20227.089780960185;20386.49033774108;20443.080061396977;20475.38573842787;18949.43151705451;18980.335688250845;19064.904675476533;19080;19175.232990680775;15010.699786004438;15060.623484412978;15127.243637818285;15260.465883694018;15358.769618455508;14123.788143177655;14220.075695079786;14245.28773561297;14271.57185284443;14293 12:17:02 INFO - PID 17923 | __end_tp_report 12:17:02 INFO - PID 17923 | __start_cc_report 12:17:02 INFO - PID 17923 | _x_x_mozilla_cycle_collect,266 12:17:02 INFO - PID 17923 | __end_cc_report 12:17:02 INFO - PID 17923 | __startTimestamp1506539822811__endTimestamp 12:17:02 INFO - PID 17923 | 12:17:02 INFO - PID 17923 | ------- Summary: start ------- 12:17:02 INFO - PID 17923 | Number of tests: 6 12:17:02 INFO - PID 17923 | 12:17:02 INFO - PID 17923 | [#0] dojo.html Cycles:165 Average:6327.77 Median:6550.31 stddev:767.62 (11.7%) stddev-sans-first:745.28 12:17:02 INFO - PID 17923 | Values: 3865.6 3902.9 3912.7 3915.2 3921.1 6220.8 6273.0 6326.1 6335.8 6428.3 6312.6 6318.0 6321.7 6326.1 6350.4 5608.1 5658.3 5673.7 5673.9 5772.5 5756.9 5774.8 5797.0 5806.5 5837.4 5709.5 5712.2 5726.2 5814.0 5816.2 5502.9 5617.8 5625.9 5694.9 5716.7 5616.2 5637.6 5728.6 5730.0 5735.7 6264.2 6269.6 6274.0 6274.2 6283.1 6873.5 6889.2 6903.7 6965.2 6968.7 6888.6 6918.7 6985.3 6992.3 6999.7 6314.3 6320.0 6338.7 6374.1 6406.9 6936.7 6964.1 7041.7 7103.3 7181.5 6688.4 6832.0 6857.7 6868.8 6880.6 6874.5 6888.7 6898.3 6984.9 6986.4 6739.0 6830.2 6839.9 6912.0 6931.2 6848.9 6854.1 6889.3 6920.5 6927.2 4887.5 4938.6 4955.7 4956.3 4970.6 4512.9 4520.6 4527.8 4538.9 4540.7 6351.7 6352.4 6354.2 6366.8 6395.6 6849.3 6855.5 6925.7 6936.3 6936.5 6213.2 6295.2 6329.6 6370.2 6384.8 5464.5 5478.4 5566.3 5570.2 5575.6 7198.2 7266.1 7290.4 7292.8 7303.1 6824.1 6847.0 6865.0 6903.9 6905.7 7065.9 7136.0 7179.0 7179.5 7182.1 6778.7 6800.0 6805.8 6838.5 6856.7 6815.3 6851.6 6883.9 6928.1 6932.6 6609.1 6649.8 6718.0 6751.3 6755.9 6627.8 6691.2 6722.0 6723.4 6724.0 6460.7 6505.2 6516.5 6608.0 6608.3 6580.4 6632.0 6697.0 6703.8 6710.4 6451.3 6520.8 6521.3 6535.2 6550.3 12:17:02 INFO - PID 17923 | 12:17:02 INFO - PID 17923 | [#1] ext.html Cycles:180 Average:42331.50 Median:19367.19 stddev:64105.82 (331.0%) stddev-sans-first:64210.30 12:17:02 INFO - PID 17923 | Values: 933.7 962.6 994.9 996.8 1018.8 43554.3 44007.3 44104.8 44496.6 44544.3 40747.2 40987.4 41034.8 41229.8 41230.6 7385.8 7443.7 7447.1 7510.3 7548.5 7447.7 7499.2 7530.2 7531.3 7536.8 8369.8 8569.5 8577.4 8577.8 8578.5 8450.7 8452.5 8504.7 8513.8 8525.1 8230.6 8358.0 8362.2 8368.9 8378.1 39788.4 40311.0 40321.6 40537.4 40543.8 3753.4 3787.0 3799.2 3811.6 3816.6 33101.8 33134.0 33139.0 33175.0 33188.7 5494.3 5502.1 5504.4 5535.6 5591.8 217866.0 218011.0 218742.9 219701.0 220380.0 52917.0 53180.0 53448.2 53524.0 53529.0 55758.0 55783.7 55860.0 55963.4 56160.0 16171.4 16533.8 16562.1 16575.3 16608.2 13242.1 13406.8 13445.0 13445.0 13463.0 15172.4 15378.6 15480.5 15591.6 15682.9 6293.3 6328.7 6412.5 6443.6 6480.0 1084.3 1096.9 1103.7 1111.0 1117.6 24084.3 24226.0 24274.0 24412.7 24497.5 1180.3 1196.4 1202.0 1211.3 1224.2 12955.5 13043.5 13138.8 13304.4 13361.3 283180.0 283300.0 283536.0 283647.0 283821.0 56519.7 61864.7 62973.4 63646.4 63703.0 1486.9 1533.9 1536.1 1539.3 1543.4 29600.0 29600.3 29990.7 30144.7 30396.8 40990.6 41194.0 41220.2 41343.0 41380.2 231497.0 231784.0 231845.0 232694.0 233201.0 34507.8 34611.5 34633.1 34641.3 34699.0 44125.0 44176.8 44593.6 45147.8 45228.5 32951.3 33405.8 33416.5 33530.0 33542.7 34139.3 34408.7 34688.7 34804.8 34981.0 39149.4 39529.6 39923.8 40132.0 40250.6 32870.8 32880.0 33139.5 33193.2 33532.5 24351.5 24461.1 24603.0 24920.9 25040.4 12:17:02 INFO - PID 17923 | 12:17:02 INFO - PID 17923 | [#2] jquery.html Cycles:180 Average:40450.67 Median:23777.64 stddev:105492.37 (443.7%) stddev-sans-first:105745.90 12:17:02 INFO - PID 17923 | Values: 615.4 631.2 634.5 638.5 643.9 23450.4 23750.5 24234.0 24328.0 24366.0 24880.5 25990.9 26032.3 26047.1 26070.1 6430.1 6584.5 6592.1 6593.4 6604.6 6351.5 6562.2 6598.9 6602.0 6603.0 6580.8 6585.3 6585.6 6588.5 6592.0 6535.3 6563.3 6565.5 6567.7 6569.0 6081.1 6122.6 6145.8 6159.6 6163.5 28636.7 29430.0 30221.7 30322.0 30385.5 2291.9 2333.2 2334.9 2335.0 2335.7 19930.4 20488.1 20569.4 20599.0 20631.9 2458.0 2513.1 2530.8 2555.4 2566.1 133397.3 140643.3 148768.3 154321.2 155323.0 15952.9 16098.3 16229.2 16309.8 17045.7 26313.5 26386.0 26580.7 26587.7 26604.2 9926.0 10119.7 10127.3 10198.1 10421.3 8985.0 9060.2 9196.6 9199.7 9298.1 9456.2 9672.6 9738.1 9961.5 9995.7 2860.6 2885.0 2911.1 2926.1 2967.2 1044.5 1047.3 1052.1 1064.5 1079.2 20682.5 20769.8 20935.6 21207.9 21304.6 1120.9 1129.1 1129.5 1138.7 1139.5 11468.1 11669.8 11714.5 11741.6 11767.4 614254.0 621986.0 638597.0 642504.0 646907.0 127836.0 129667.0 132231.3 132738.3 135213.0 1087.7 1124.9 1170.3 1172.3 1231.8 21501.5 22366.0 22383.6 22445.0 22539.3 60917.4 62568.1 63621.7 63688.0 64975.7 77414.6 78090.0 78829.6 78886.0 78897.8 15429.2 15792.6 15971.1 15984.4 15992.6 23804.8 23876.9 24105.8 24291.4 24319.8 19719.9 19750.2 19849.6 19921.7 20076.7 17531.5 17584.4 18020.8 18267.5 18443.9 19763.2 19967.6 19982.0 20105.3 20121.0 15617.6 15673.7 15678.8 15689.5 15710.9 19218.0 19225.2 19405.5 19411.9 19587.1 12:17:02 INFO - PID 17923 | 12:17:02 INFO - PID 17923 | [#3] mootools.html Cycles:180 Average:10512.37 Median:2687.11 stddev:7777.14 (289.4%) stddev-sans-first:7768.88 12:17:02 INFO - PID 17923 | Values: 1408.6 1456.2 1475.4 1484.6 1485.1 17246.9 17942.9 17948.9 17973.0 17987.8 17260.2 17802.1 17834.4 17845.5 17858.7 2815.1 2868.9 2875.2 2884.4 2888.3 2646.9 2678.3 2679.8 2683.2 2749.8 2796.3 2848.7 2849.3 2851.1 2851.4 2670.6 2712.1 2712.4 2712.7 2712.8 2670.9 2691.1 2692.1 2695.2 2697.5 16273.2 16645.1 16698.7 16709.5 16720.0 8334.9 8548.2 8621.7 8644.6 8647.6 5409.7 5617.1 5703.6 5733.8 5772.9 2085.2 2177.7 2189.6 2221.7 2234.3 29879.7 30101.7 30208.5 30229.4 30367.8 7105.2 7341.4 7359.5 7507.9 7548.5 19663.9 19667.1 19763.4 19770.1 22515.7 8669.4 8918.1 8922.7 8946.1 8951.1 7878.7 7913.6 8084.4 8120.4 8173.7 5957.7 6121.7 6132.2 6184.9 6212.3 1729.3 1786.3 1800.5 1803.9 1836.1 951.8 959.5 981.8 987.2 990.2 8182.2 8193.3 8206.9 8214.7 8304.2 798.9 802.6 806.2 813.1 824.7 4759.6 4845.8 4849.2 4881.0 4918.0 24163.6 24693.0 24821.9 25631.2 25644.5 24341.9 24615.0 25160.6 25172.2 25301.9 12648.5 12728.9 12818.4 12891.8 12941.7 9197.8 9347.0 9377.2 9381.1 9657.2 20316.3 20502.4 20856.2 21200.3 21376.0 22239.9 22371.6 22381.9 22553.1 22593.5 13490.6 13499.3 13625.1 13656.9 13795.2 15425.3 15562.5 15572.5 15584.8 15588.8 12188.9 12346.2 12462.1 12476.1 12578.9 12147.9 12376.8 12499.8 12641.0 12735.2 10669.8 10753.9 10783.6 10816.6 10817.9 8363.5 8448.4 8495.6 8565.8 8593.7 8412.5 8437.7 8443.3 8483.8 8583.3 12:17:02 INFO - PID 17923 | 12:17:02 INFO - PID 17923 | [#4] prototype.html Cycles:180 Average:5811.14 Median:6293.69 stddev:1544.50 (24.5%) stddev-sans-first:1497.66 12:17:02 INFO - PID 17923 | Values: 557.7 558.4 566.2 585.9 589.8 5955.6 6156.0 6200.5 6252.4 6271.2 6156.9 6212.1 6227.4 6238.3 6279.4 5201.7 5218.5 5226.5 5234.2 5264.4 5151.7 5237.3 5269.8 5286.7 5311.8 5129.6 5201.0 5218.3 5224.9 5278.2 5134.8 5226.7 5268.6 5274.1 5311.2 4985.2 4998.8 4999.6 5007.5 5017.9 6222.5 6309.7 6320.5 6391.3 6398.2 6258.7 6292.5 6294.9 6308.9 6315.8 6772.3 6804.5 6823.0 6843.5 6852.6 5239.4 5513.6 5557.9 5579.6 5603.2 6877.7 7013.3 7041.5 7071.5 7087.2 5735.6 5738.1 5743.2 5775.8 5777.6 5772.6 5844.0 5856.8 5868.2 5870.9 6200.0 6217.5 6254.4 6257.8 6282.9 6747.8 6788.6 6816.5 6822.9 6831.6 2002.6 2027.8 2028.2 2039.7 2044.9 1457.2 1513.8 1538.1 1544.5 1553.3 6068.5 6104.9 6113.8 6297.2 6329.5 6613.5 6642.0 6716.3 6736.2 6775.0 6132.5 6143.2 6204.6 6242.5 6262.3 3484.7 3586.4 3597.5 3644.0 3664.7 7120.6 7155.4 7174.7 7206.8 7206.8 6957.2 6999.9 7011.5 7012.2 7016.0 7005.4 7040.7 7086.0 7093.4 7135.8 6731.9 6769.3 6770.8 6809.7 6835.2 6682.7 6686.6 6689.4 6771.4 6832.7 6958.7 7066.2 7068.7 7179.9 7182.4 5639.0 5687.3 5695.0 5722.9 5782.2 6539.3 6701.9 6868.3 6907.8 6940.9 6630.9 6636.1 6638.0 6692.1 6711.3 6605.7 6615.3 6656.4 6663.4 6676.1 6593.2 6593.5 6593.7 6595.8 6602.7 6556.2 6605.0 6729.6 6738.0 6777.3 6538.2 6545.5 6547.7 6560.7 6567.3 12:17:02 INFO - PID 17923 | 12:17:02 INFO - PID 17923 | [#5] yui.html Cycles:180 Average:28896.16 Median:19472.00 stddev:42790.56 (219.8%) stddev-sans-first:42859.29 12:17:02 INFO - PID 17923 | Values: 988.6 996.6 1004.7 1025.9 1027.9 19836.4 20585.3 20901.5 20911.2 20920.3 19514.1 19667.3 19733.7 19764.3 19766.6 1020.9 1048.2 1048.5 1048.5 1048.5 1050.4 1050.7 1050.7 1051.5 1056.6 1084.9 1117.4 1119.6 1120.8 1131.3 1117.4 1119.4 1122.6 1124.2 1128.3 818.4 819.1 820.8 821.4 825.8 19237.8 19367.5 19612.0 19790.8 19821.6 21276.3 21704.7 22054.8 22068.7 22079.8 18498.4 18638.8 18691.6 18723.0 18840.3 3860.7 3889.6 3897.7 4081.1 4086.6 128581.0 139936.9 159973.0 160097.0 164196.2 18234.5 18287.5 18386.4 18477.4 18521.4 33271.3 34058.3 34203.5 34262.8 34272.7 9124.9 9554.3 9636.8 9649.8 9650.1 4504.8 4601.2 4615.5 4644.2 4675.3 6306.3 6339.7 6343.5 6426.4 6429.5 1216.6 1220.6 1223.5 1230.9 1246.6 726.4 744.6 745.3 752.0 760.3 13324.3 13359.0 13387.3 13826.7 13867.0 743.5 747.4 753.9 759.5 761.3 6518.0 6633.2 6670.1 6713.3 6762.4 154278.2 159699.0 159999.0 160599.0 161254.2 113592.0 132093.0 138009.0 139589.0 141180.3 120802.4 121316.0 122747.4 123376.0 124169.0 13771.6 14146.6 14372.1 14401.1 14578.9 52414.5 53859.2 54444.0 54993.5 55289.0 70332.0 70596.3 72182.6 73014.6 73930.3 19196.0 19480.0 19568.7 19597.2 19876.3 20506.0 20523.8 20554.5 20768.3 20862.6 19127.2 19389.8 19448.7 19460.7 19464.0 20113.9 20227.1 20386.5 20443.1 20475.4 18949.4 18980.3 19064.9 19080.0 19175.2 15010.7 15060.6 15127.2 15260.5 15358.8 14123.8 14220.1 14245.3 14271.6 14293.0 12:17:02 INFO - PID 17923 | -------- Summary: end -------- 12:17:02 INFO - PID 17923 | 12:17:03 INFO - TEST-INFO | 17923: exit 0 12:17:03 INFO - TEST-OK | dromaeo_css | took 1109340ms 12:17:03 INFO - TEST-START | kraken 12:17:03 INFO - Initialising browser for kraken test... 12:17:03 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:59720/getInfo.html -profile /tmp/tmpDwjOfZ/profile 12:17:03 INFO - TEST-INFO | started process 18299 (/builds/slave/test/build/application/firefox/firefox http://localhost:59720/getInfo.html) 12:17:09 INFO - TEST-INFO | 18299: exit 0 12:17:09 INFO - Browser initialized. 12:17:09 INFO - Running cycle 1/1 for kraken test... 12:17:09 INFO - Using env: {'DISPLAY': ':0', 12:17:09 INFO - 'HOME': '/home/cltbld', 12:17:09 INFO - 'JSGC_DISABLE_POISONING': '1', 12:17:09 INFO - 'LANG': 'en_US.UTF-8', 12:17:09 INFO - 'LANGUAGE': 'en_US:en', 12:17:09 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 12:17:09 INFO - 'LOGNAME': 'cltbld', 12:17:09 INFO - 'MAIL': '/var/mail/cltbld', 12:17:09 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:17:09 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 12:17:09 INFO - 'MOZ_CRASHREPORTER': '1', 12:17:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:17:09 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 12:17:09 INFO - 'MOZ_NO_REMOTE': '1', 12:17:09 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:17:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:17:09 INFO - 'NO_EM_RESTART': '1', 12:17:09 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:17:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:17:09 INFO - 'PWD': '/builds/slave/test', 12:17:09 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:17:09 INFO - 'RUST_BACKTRACE': 'full', 12:17:09 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 12:17:09 INFO - 'SHELL': '/bin/bash', 12:17:09 INFO - 'SHLVL': '1', 12:17:09 INFO - 'STYLO_FORCE_DISABLED': '1', 12:17:09 INFO - 'TERM': 'linux', 12:17:09 INFO - 'TMOUT': '86400', 12:17:09 INFO - 'USER': 'cltbld', 12:17:09 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1506538647.591657-324272956', 12:17:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:17:09 INFO - '_': '/tools/buildbot/bin/python'} 12:17:09 INFO - TEST-INFO | started process 18536 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDwjOfZ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 12:17:10 INFO - PID 18536 | 12:17:10 INFO - PID 18536 | (/builds/slave/test/build/application/firefox/firefox:18585): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 12:17:10 INFO - PID 18536 | 12:17:20 INFO - PID 18536 | RSS: Main: 144326656 12:17:20 INFO - PID 18536 | 12:17:22 INFO - PID 18536 | Cycle 1(1): loaded http://localhost:59720/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59720/tests/kraken/driver.html?testName=audio-beat-detection) 12:17:23 INFO - PID 18536 | RSS: Main: 150822912 12:17:23 INFO - PID 18536 | 12:17:26 INFO - PID 18536 | Cycle 1(1): loaded http://localhost:59720/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59720/tests/kraken/driver.html?testName=audio-dft) 12:17:27 INFO - PID 18536 | RSS: Main: 151449600 12:17:27 INFO - PID 18536 | 12:17:29 INFO - PID 18536 | Cycle 1(1): loaded http://localhost:59720/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59720/tests/kraken/driver.html?testName=audio-fft) 12:17:30 INFO - PID 18536 | RSS: Main: 146989056 12:17:30 INFO - PID 18536 | 12:17:32 INFO - PID 18536 | Cycle 1(1): loaded http://localhost:59720/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59720/tests/kraken/driver.html?testName=audio-oscillator) 12:17:33 INFO - PID 18536 | RSS: Main: 147984384 12:17:33 INFO - PID 18536 | 12:17:35 INFO - PID 18536 | Cycle 1(1): loaded http://localhost:59720/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59720/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:17:35 INFO - PID 18536 | RSS: Main: 147832832 12:17:35 INFO - PID 18536 | 12:17:39 INFO - PID 18536 | Cycle 1(1): loaded http://localhost:59720/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59720/tests/kraken/driver.html?testName=imaging-darkroom) 12:17:39 INFO - PID 18536 | RSS: Main: 147714048 12:17:39 INFO - PID 18536 | 12:17:43 INFO - PID 18536 | Cycle 1(1): loaded http://localhost:59720/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59720/tests/kraken/driver.html?testName=imaging-desaturate) 12:17:43 INFO - PID 18536 | RSS: Main: 150454272 12:17:43 INFO - PID 18536 | 12:17:46 INFO - PID 18536 | Cycle 1(1): loaded http://localhost:59720/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59720/tests/kraken/driver.html?testName=json-parse-financial) 12:17:47 INFO - PID 18536 | RSS: Main: 151056384 12:17:47 INFO - PID 18536 | 12:17:48 INFO - PID 18536 | Cycle 1(1): loaded http://localhost:59720/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59720/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:17:49 INFO - PID 18536 | RSS: Main: 151252992 12:17:49 INFO - PID 18536 | 12:17:50 INFO - PID 18536 | Cycle 1(1): loaded http://localhost:59720/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59720/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:17:51 INFO - PID 18536 | RSS: Main: 151187456 12:17:51 INFO - PID 18536 | 12:17:53 INFO - PID 18536 | Cycle 1(1): loaded http://localhost:59720/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59720/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:17:54 INFO - PID 18536 | RSS: Main: 148230144 12:17:54 INFO - PID 18536 | 12:17:56 INFO - PID 18536 | Cycle 1(1): loaded http://localhost:59720/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59720/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:17:57 INFO - PID 18536 | RSS: Main: 148008960 12:17:57 INFO - PID 18536 | 12:18:00 INFO - PID 18536 | Cycle 1(1): loaded http://localhost:59720/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59720/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:18:00 INFO - PID 18536 | RSS: Main: 148492288 12:18:00 INFO - PID 18536 | 12:18:02 INFO - PID 18536 | Cycle 1(1): loaded http://localhost:59720/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59720/tests/kraken/driver.html?testName=ai-astar) 12:18:02 INFO - PID 18536 | RSS: Main: 150011904 12:18:02 INFO - PID 18536 | 12:18:02 INFO - PID 18536 | __start_tp_report 12:18:02 INFO - PID 18536 | _x_x_mozilla_page_load 12:18:02 INFO - PID 18536 | _x_x_mozilla_page_load_details 12:18:02 INFO - PID 18536 | |i|pagename|runs| 12:18:02 INFO - PID 18536 | |0;ai-astar;106;105;106;106;105;107;106;105;105;105 12:18:02 INFO - PID 18536 | |1;audio-beat-detection;112;122;111;112;112;112;144;113;137;117 12:18:02 INFO - PID 18536 | |2;audio-dft;163;161;163;161;163;162;162;162;169;165 12:18:02 INFO - PID 18536 | |3;audio-fft;74;74;73;73;72;76;74;76;74;72 12:18:02 INFO - PID 18536 | |4;audio-oscillator;78;78;79;77;78;78;78;78;78;80 12:18:02 INFO - PID 18536 | |5;imaging-gaussian-blur;114;114;113;113;114;114;113;113;113;114 12:18:02 INFO - PID 18536 | |6;imaging-darkroom;149;150;150;149;150;149;151;150;151;151 12:18:02 INFO - PID 18536 | |7;imaging-desaturate;94;95;98;94;94;94;94;99;94;96 12:18:02 INFO - PID 18536 | |8;json-parse-financial;43;44;53;49;44;45;44;44;42;45 12:18:02 INFO - PID 18536 | |9;json-stringify-tinderbox;37;37;36;37;37;39;37;37;36;37 12:18:02 INFO - PID 18536 | |10;stanford-crypto-aes;72;70;70;71;71;71;72;68;69;75 12:18:02 INFO - PID 18536 | |11;stanford-crypto-ccm;114;108;109;106;111;116;106;112;111;108 12:18:02 INFO - PID 18536 | |12;stanford-crypto-pbkdf2;152;147;152;150;149;156;152;156;150;150 12:18:02 INFO - PID 18536 | |13;stanford-crypto-sha256-iterative;65;64;62;61;64;62;58;60;60;60 12:18:02 INFO - PID 18536 | __end_tp_report 12:18:02 INFO - PID 18536 | __start_cc_report 12:18:02 INFO - PID 18536 | _x_x_mozilla_cycle_collect,731 12:18:02 INFO - PID 18536 | __end_cc_report 12:18:02 INFO - PID 18536 | __startTimestamp1506539882570__endTimestamp 12:18:02 INFO - PID 18536 | 12:18:02 INFO - PID 18536 | ------- Summary: start ------- 12:18:02 INFO - PID 18536 | Number of tests: 14 12:18:02 INFO - PID 18536 | 12:18:02 INFO - PID 18536 | [#0] ai-astar Cycles:10 Average:105.60 Median:106.00 stddev:0.70 (0.7%) stddev-sans-first:0.73 12:18:02 INFO - PID 18536 | Values: 106.0 105.0 106.0 106.0 105.0 107.0 106.0 105.0 105.0 105.0 12:18:02 INFO - PID 18536 | 12:18:02 INFO - PID 18536 | [#1] audio-beat-detection Cycles:10 Average:119.20 Median:115.00 stddev:11.82 (10.3%) stddev-sans-first:12.25 12:18:02 INFO - PID 18536 | Values: 112.0 122.0 111.0 112.0 112.0 112.0 144.0 113.0 137.0 117.0 12:18:02 INFO - PID 18536 | 12:18:02 INFO - PID 18536 | [#2] audio-dft Cycles:10 Average:163.10 Median:163.00 stddev:2.38 (1.5%) stddev-sans-first:2.52 12:18:02 INFO - PID 18536 | Values: 163.0 161.0 163.0 161.0 163.0 162.0 162.0 162.0 169.0 165.0 12:18:02 INFO - PID 18536 | 12:18:02 INFO - PID 18536 | [#3] audio-fft Cycles:10 Average:73.80 Median:74.00 stddev:1.40 (1.9%) stddev-sans-first:1.48 12:18:02 INFO - PID 18536 | Values: 74.0 74.0 73.0 73.0 72.0 76.0 74.0 76.0 74.0 72.0 12:18:02 INFO - PID 18536 | 12:18:02 INFO - PID 18536 | [#4] audio-oscillator Cycles:10 Average:78.20 Median:78.00 stddev:0.79 (1.0%) stddev-sans-first:0.83 12:18:02 INFO - PID 18536 | Values: 78.0 78.0 79.0 77.0 78.0 78.0 78.0 78.0 78.0 80.0 12:18:02 INFO - PID 18536 | 12:18:02 INFO - PID 18536 | [#5] imaging-gaussian-blur Cycles:10 Average:113.50 Median:114.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 12:18:02 INFO - PID 18536 | Values: 114.0 114.0 113.0 113.0 114.0 114.0 113.0 113.0 113.0 114.0 12:18:02 INFO - PID 18536 | 12:18:02 INFO - PID 18536 | [#6] imaging-darkroom Cycles:10 Average:150.00 Median:150.00 stddev:0.82 (0.5%) stddev-sans-first:0.78 12:18:02 INFO - PID 18536 | Values: 149.0 150.0 150.0 149.0 150.0 149.0 151.0 150.0 151.0 151.0 12:18:02 INFO - PID 18536 | 12:18:02 INFO - PID 18536 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:94.50 stddev:1.87 (2.0%) stddev-sans-first:1.94 12:18:02 INFO - PID 18536 | Values: 94.0 95.0 98.0 94.0 94.0 94.0 94.0 99.0 94.0 96.0 12:18:02 INFO - PID 18536 | 12:18:02 INFO - PID 18536 | [#8] json-parse-financial Cycles:10 Average:45.30 Median:44.50 stddev:3.27 (7.3%) stddev-sans-first:3.36 12:18:02 INFO - PID 18536 | Values: 43.0 44.0 53.0 49.0 44.0 45.0 44.0 44.0 42.0 45.0 12:18:02 INFO - PID 18536 | 12:18:02 INFO - PID 18536 | [#9] json-stringify-tinderbox Cycles:10 Average:37.00 Median:37.00 stddev:0.82 (2.2%) stddev-sans-first:0.87 12:18:02 INFO - PID 18536 | Values: 37.0 37.0 36.0 37.0 37.0 39.0 37.0 37.0 36.0 37.0 12:18:02 INFO - PID 18536 | 12:18:02 INFO - PID 18536 | [#10] stanford-crypto-aes Cycles:10 Average:70.90 Median:71.00 stddev:1.91 (2.7%) stddev-sans-first:1.99 12:18:02 INFO - PID 18536 | Values: 72.0 70.0 70.0 71.0 71.0 71.0 72.0 68.0 69.0 75.0 12:18:02 INFO - PID 18536 | 12:18:02 INFO - PID 18536 | [#11] stanford-crypto-ccm Cycles:10 Average:110.10 Median:111.00 stddev:3.31 (3.0%) stddev-sans-first:3.20 12:18:02 INFO - PID 18536 | Values: 114.0 108.0 109.0 106.0 111.0 116.0 106.0 112.0 111.0 108.0 12:18:02 INFO - PID 18536 | 12:18:02 INFO - PID 18536 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:151.40 Median:152.00 stddev:2.88 (1.9%) stddev-sans-first:3.04 12:18:02 INFO - PID 18536 | Values: 152.0 147.0 152.0 150.0 149.0 156.0 152.0 156.0 150.0 150.0 12:18:02 INFO - PID 18536 | 12:18:02 INFO - PID 18536 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:61.60 Median:62.00 stddev:2.22 (3.6%) stddev-sans-first:1.99 12:18:02 INFO - PID 18536 | Values: 65.0 64.0 62.0 61.0 64.0 62.0 58.0 60.0 60.0 60.0 12:18:02 INFO - PID 18536 | -------- Summary: end -------- 12:18:02 INFO - PID 18536 | 12:18:03 INFO - PID 18536 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 12:18:03 INFO - TEST-INFO | 18536: exit 0 12:18:03 INFO - TEST-OK | kraken | took 59708ms 12:18:03 INFO - SUITE-END | took 1169s 12:18:03 INFO - Completed test suite (00:19:29) 12:18:03 INFO - javascript benchmark 12:18:03 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s", "stylo_disabled"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 9179.846707036026, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3865.613438656134, 3902.9414558781605, 3912.74567153135, 3915.1973845361704, 3921.1373497830486, 6220.813375598728, 6273.0, 6326.145970294009, 6335.841603959903, 6428.292887782341, 6312.589681670688, 6318.020706790443, 6321.7155228014735, 6326.14597029402, 6350.42846143847, 5608.130739735328, 5658.321001479808, 5673.6879471629045, 5673.8581535461635, 5772.509336706385, 5756.884862302752, 5774.769009239625, 5797.043487824504, 5806.477417032466, 5837.357890632027, 5709.514691251248, 5712.200291959129, 5726.169705392736, 5813.970930145343, 5816.185733997244, 5502.889942201174, 5617.8033768817895, 5625.887482250332, 5694.857628559278, 5716.685582292972, 5616.241807355996, 5637.63355381903, 5728.570357223225, 5729.9713501432225, 5735.713214339308, 6264.248290205159, 6269.561130720851, 6273.968630156865, 6274.1843560336865, 6283.120363149163, 6873.518853680244, 6889.207741109736, 6903.689333979983, 6965.164180298397, 6968.721251149948, 6888.621125838077, 6918.723251069951, 6985.336393042653, 6992.3357281058215, 6999.650017499104, 6314.336994615545, 6320.0, 6338.746450141989, 6374.075759014963, 6406.93593064068, 6936.653167341613, 6964.129483814523, 7041.683124259421, 7103.289671032855, 7181.4972951893915, 6688.3646053624825, 6832.043513908056, 6857.691403886837, 6868.828279292958, 6880.552764070319, 6874.450043996569, 6888.690008949609, 6898.344657257653, 6984.930150698529, 6986.371226589631, 6738.966305168541, 6830.21452532965, 6839.93160068393, 6911.965440172767, 6931.202911665223, 6848.931510684929, 6854.108965834509, 6889.311068893171, 6920.4809639277255, 6927.203371612329, 4887.462379138292, 4938.629602779734, 4955.727434991038, 4956.330895329084, 4970.552650261494, 4512.932306015412, 4520.638348932078, 4527.84152554659, 4538.931916021263, 4540.704854184468, 6351.714172862232, 6352.396522330371, 6354.237491500957, 6366.84082897922, 6395.552311338255, 6849.315068493111, 6855.485838562127, 6925.653717314114, 6936.271691472322, 6936.4797640177185, 6213.161223234896, 6295.181626388632, 6329.556931014785, 6370.1718776558755, 6384.776532821329, 5464.480874316933, 5478.397376288605, 5566.304211973504, 5570.192322113352, 5575.637583557056, 7198.172210195789, 7266.128064632172, 7290.4167666586545, 7292.781216563511, 7303.087114110736, 6824.078749368771, 6847.041414201916, 6864.965675171592, 6903.896441553381, 6905.723771049102, 7065.894011589933, 7135.964320178574, 7178.964105179441, 7179.533330333512, 7182.066331376887, 6778.661066946732, 6799.966000169968, 6805.761798337035, 6838.452923766186, 6856.657167141722, 6815.284395138439, 6851.588904665736, 6883.931160688329, 6928.099347084847, 6932.618705971018, 6609.140811694641, 6649.767258145942, 6718.0, 6751.3248675134055, 6755.864882702417, 6627.834304142435, 6691.197056353269, 6722.0, 6723.361280678328, 6723.966380168068, 6460.676966151767, 6505.154329937267, 6516.5112616553, 6608.041833934149, 6608.306127856506, 6580.374864387875, 6632.0, 6696.966515167393, 6703.765368212089, 6710.396064354231, 6451.258105317761, 6520.771772988112, 6521.347865213441, 6535.183102112236, 6550.312217217123], "value": 6274.512754435657, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [933.6638810028393, 962.6486332488644, 994.8905620381756, 996.8355221388472, 1018.8064267789124, 43554.34668479971, 44007.339889901676, 44104.77947610257, 44496.55503444961, 44544.3318350225, 40747.185056298855, 40987.385189222114, 41034.7948260259, 41229.7938510307, 41230.58769412305, 7385.778426647209, 7443.665035073408, 7447.143578488489, 7510.324070833624, 7548.471606987513, 7447.739329123455, 7499.175090740015, 7530.246975302481, 7531.3221810037085, 7536.773896783106, 8369.790755231106, 8569.485830850137, 8577.39958202926, 8577.785555361135, 8578.485290882536, 8450.704225352114, 8452.535110568917, 8504.74485765422, 8513.787155321104, 8525.062243153248, 8230.588470576447, 8357.958210208972, 8362.247397734172, 8368.916310836936, 8378.12029736881, 39788.403173952414, 40311.0, 40321.59678403208, 40537.391939120644, 40543.79728101341, 3753.380692185786, 3786.9621303786885, 3799.1831756172555, 3811.5616704079107, 3816.5610954740005, 33101.834490827634, 33134.0, 33139.0, 33175.0, 33188.668113318796, 5494.314081668185, 5502.119660854244, 5504.394516603171, 5535.557155427556, 5591.832245032656, 217866.0, 218011.0, 218742.90628546916, 219701.0, 220380.0, 52917.0, 53180.0, 53448.19827702588, 53524.0, 53529.0, 55758.0, 55783.72108139433, 55860.0, 55963.44036559664, 56160.0, 16171.43399980995, 16533.83466165347, 16562.089085100437, 16575.336986520404, 16608.16959152062, 13242.139260948008, 13406.798898016537, 13445.0, 13445.0, 13463.0, 15172.393104275927, 15378.615534611501, 15480.5355839325, 15591.610209744847, 15682.921585392, 6293.2762732285455, 6328.6835658216905, 6412.454941330039, 6443.581167224115, 6480.0, 1084.311462221495, 1096.9286996345213, 1103.6578660615235, 1111.0278506306981, 1117.5976648406568, 24084.27747167588, 24226.0, 24274.0, 24412.657303848104, 24497.510049798904, 1180.2800291821982, 1196.4077781498213, 1201.963941081769, 1211.3277131192274, 1224.161449407159, 12955.5465558705, 13043.543475978486, 13138.802917956238, 13304.401301941436, 13361.331933403291, 283180.0, 283300.0, 283536.0, 283647.0, 283821.0, 56519.71740141273, 61864.69067654633, 62973.37026629675, 63646.36353636404, 63703.0, 1486.8661820436212, 1533.877289816812, 1536.093704714224, 1539.3073117097126, 1543.3517922472588, 29600.0, 29600.259993499472, 29990.70009299879, 30144.69855301419, 30396.84801575978, 40990.590094098676, 41194.0, 41220.1755964885, 41343.0, 41380.1723965513, 231497.0, 231784.0, 231845.0, 232694.0, 233201.0, 34507.827460862536, 34611.48082778811, 34633.1341716449, 34641.30717385588, 34698.959031229104, 44125.0, 44176.77911610421, 44593.55406445894, 45147.774261128485, 45228.547714522436, 32951.340973179926, 33405.83297083499, 33416.49875251922, 33530.0, 33542.66457335493, 34139.31721365509, 34408.65591344055, 34688.65311346854, 34804.82597586996, 34981.0, 39149.41275880921, 39529.604703952595, 39923.80038099791, 40132.0, 40250.59749402468, 32870.835645821615, 32880.0, 33139.50290745689, 33193.17017074592, 33532.49701254532, 24351.51296974086, 24461.143859964817, 24602.956393938843, 24920.875395622905, 25040.37399065038], "value": 18547.720789891788, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [615.3600255734037, 631.151101768122, 634.5019159959432, 638.5306799502367, 643.9195100612424, 23450.413739656517, 23750.524989500198, 24234.0, 24328.0, 24365.999999999978, 24880.50238995219, 25990.870045649746, 26032.34919127018, 26047.088351907638, 26070.08754693586, 6430.131932189153, 6584.506162037842, 6592.077109204715, 6593.3736295051895, 6604.636744979024, 6351.491880649537, 6562.179727534059, 6598.93401065988, 6602.0, 6603.0, 6580.835479113012, 6585.308542603029, 6585.604863708193, 6588.538802283842, 6592.044153597725, 6535.281119076922, 6563.343665633446, 6565.474762019075, 6567.671616419184, 6569.0, 6081.148639190517, 6122.571420000601, 6145.8156255312415, 6159.568830181889, 6163.476104531121, 28636.713632863823, 29430.0, 30221.697783022108, 30322.0, 30385.544216836766, 2291.873946932918, 2333.230034088747, 2334.9182778602667, 2335.0, 2335.7313908900355, 19930.402087937386, 20488.078036488245, 20569.382918512467, 20599.0, 20631.896840515703, 2457.9877100614563, 2513.0576033987254, 2530.8481491110592, 2555.3611597100726, 2566.0762125634756, 133397.33301333527, 140643.29678351645, 148768.2561587196, 154321.22839385844, 155323.0, 15952.92023539875, 16098.275577599035, 16229.188540572924, 16309.83690163107, 17045.659086818196, 26313.473730525282, 26386.0, 26580.734192657826, 26587.734122658527, 26604.201873943814, 9925.950370248247, 10119.7470063249, 10127.291089623655, 10198.133158681447, 10421.322614030063, 8985.0, 9060.229880460103, 9196.632134714537, 9199.678011269574, 9298.070192980784, 9456.243500519942, 9672.56473458696, 9738.101070291366, 9961.505774133939, 9995.70012899614, 2860.613817134702, 2884.97115028847, 2911.097559756482, 2926.1221633510286, 2967.2285205846206, 1044.5247412427327, 1047.298310132198, 1052.1214785654065, 1064.5422468338534, 1079.1582565598846, 20682.482937926372, 20769.792302077087, 20935.58128837445, 21207.8939605301, 21304.573908522052, 1120.9327440353604, 1129.1023636209234, 1129.4522156753967, 1138.698244965085, 1139.5441823270592, 11468.13988950832, 11669.766604667859, 11714.472848721827, 11741.647750567327, 11767.411629418495, 614254.0, 621986.0, 638597.0, 642504.0, 646907.0, 127836.0, 129667.0, 132231.33884330516, 132738.33630831784, 135213.0, 1087.7280679830042, 1124.8706398764084, 1170.2744298534792, 1172.3083380805365, 1231.8275441438207, 21501.46246343854, 22366.0, 22383.552328953654, 22445.0, 22539.32382028542, 60917.39082609117, 62568.06147907876, 63621.68189159025, 63688.0, 64975.67512162409, 77414.612926935, 78090.0, 78829.60585197038, 78886.0, 78897.8165327532, 15429.151396673291, 15792.60518487047, 15971.121588312755, 15984.440544580884, 15992.600184995468, 23804.761952380253, 23876.880615596812, 24105.75894241035, 24291.39271518226, 24319.756802432457, 19719.901400492905, 19750.209991600175, 19849.603007939473, 19921.701174482685, 20076.698849516975, 17531.474055778348, 17584.38454654132, 18020.819791801914, 18267.53859691248, 18443.907780461013, 19763.209471620976, 19967.60064798725, 19982.0, 20105.29631462892, 20120.99395030272, 15617.609559761097, 15673.68652626964, 15678.764818527503, 15689.450869219523, 15710.9214453927, 19218.0, 19225.230990760214, 19405.514862127995, 19411.902940485208, 19587.118579663664], "value": 12782.892998967229, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1408.598549413417, 1456.1990905002253, 1475.4467074846932, 1484.5768955847582, 1485.0718301061836, 17246.91376543117, 17942.91028544857, 17948.910255448736, 17973.0, 17987.82012179881, 17260.22328995195, 17802.109894505254, 17834.375796847115, 17845.464636060908, 17858.732119018227, 2815.1413818785263, 2868.8709008094684, 2875.151830210093, 2884.408696217281, 2888.335682792959, 2646.894124235038, 2678.2500899748006, 2679.8124131310815, 2683.168217852462, 2749.8212616179985, 2796.258991367289, 2848.6581610206804, 2849.3019210293505, 2851.073401144626, 2851.3726980064457, 2670.612761149632, 2712.050782226225, 2712.403271280315, 2712.715164907676, 2712.823666461674, 2670.919872403831, 2691.0581296546247, 2692.0846912049997, 2695.17797071893, 2697.527932611785, 16273.186340683036, 16645.084520351375, 16698.749518757228, 16709.498715038568, 16720.0, 8334.874976875351, 8548.187922147386, 8621.741347759576, 8644.610992505352, 8647.610857511427, 5409.675419474844, 5617.129344951539, 5703.572232082611, 5733.77064917407, 5772.855678608026, 2085.1971990783504, 2177.738671359431, 2189.5949249388914, 2221.7222847144108, 2234.3297010896827, 29879.701202987908, 30101.69898301011, 30208.54687179694, 30229.395412091635, 30367.848160759277, 7105.182903966007, 7341.375983041501, 7359.521631093961, 7507.887381689279, 7548.509346892544, 19663.901680491505, 19667.114979825943, 19763.40709778709, 19770.11034503422, 22515.662265066036, 8669.436486628349, 8918.063603321687, 8922.68770593026, 8946.105389461132, 8951.060138685474, 7878.684852605947, 7913.604319783988, 8084.3936704747375, 8120.3503719702285, 8173.713920012771, 5957.702114894238, 6121.724522396503, 6132.233470816148, 6184.907226391608, 6212.347703491158, 1729.2564197394988, 1786.2854858056621, 1800.468861685806, 1803.873728838995, 1836.1003108477016, 951.8286708392417, 959.4930528916681, 981.8379967305458, 987.2398253344884, 990.1534188268927, 8182.1817818217705, 8193.262606365337, 8206.876896846552, 8214.671413143407, 8304.169583041768, 798.9041315042232, 802.5626033811586, 806.1736719862071, 813.1096449387911, 824.6660102658433, 4759.595434388047, 4845.781939812717, 4849.224124140121, 4880.95119048805, 4917.967226882323, 24163.63754543683, 24693.0, 24821.87589062043, 25631.23106306814, 25644.48711025769, 24341.878290608434, 24615.0, 25160.622590661154, 25172.24483265505, 25301.873490632428, 12648.494060237672, 12728.936355318165, 12818.359082045861, 12891.806622900664, 12941.741165176643, 9197.816043679222, 9346.953265233631, 9377.202937750368, 9381.061893810564, 9657.22742180638, 20316.28892988738, 20502.38492845217, 20856.165753369696, 21200.257990970244, 21376.038078286205, 22239.888800555895, 22371.552568948857, 22381.88809055944, 22553.097876084772, 22593.548129037656, 13490.595282141552, 13499.32503374847, 13625.114367566077, 13656.93171534136, 13795.172289662652, 15425.305861236047, 15562.533124006299, 15572.454964076656, 15584.766228506354, 15588.766168507254, 12188.939055304667, 12346.197497162655, 12462.065345098972, 12476.126671132934, 12578.874211257771, 12147.878521214674, 12376.81434778497, 12499.812502812283, 12641.0, 12735.172213806072, 10669.786604267716, 10753.89246107529, 10783.568657253936, 10816.621418250323, 10817.891821082003, 8363.540005299767, 8448.366372521963, 8495.575221239036, 8565.785855353417, 8593.742187734379, 8412.453190542596, 8437.704680336159, 8443.282321002784, 8483.787905302417, 8583.270422014199], "value": 7311.713693934182, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [557.7434380185114, 558.3885645218487, 566.1818672018932, 585.9326177489585, 589.811260396673, 5955.642661440311, 6155.969220153898, 6200.534959878005, 6252.437280644741, 6271.1847459830215, 6156.876862462759, 6212.1303017577575, 6227.377262273771, 6238.313785483593, 6279.357972376022, 5201.661891977028, 5218.478152184789, 5226.451222621627, 5234.18870075139, 5264.394594621629, 5151.665141765773, 5237.292965449654, 5269.841904742864, 5286.65636733613, 5311.840644780644, 5129.563987061104, 5200.973995130038, 5218.295530103444, 5224.85053288276, 5278.155495120782, 5134.768935397916, 5226.712530810785, 5268.578513718893, 5274.103402421598, 5311.167647161723, 4985.202367621199, 4998.825041123543, 4999.550040496373, 5007.549320561167, 5017.867406352322, 6222.502199824004, 6309.71606277714, 6320.494360451153, 6391.296957334689, 6398.168238129014, 6258.687065646745, 6292.4966002719675, 6294.874102517924, 6308.905366419462, 6315.810525684236, 6772.322767723237, 6804.523683342168, 6823.021323816088, 6843.486738494633, 6852.554583952027, 5239.397469291042, 5513.594033521466, 5557.944420555783, 5579.581531385163, 5603.187537806995, 6877.690503927335, 7013.333733295329, 7041.542299750551, 7071.540349877241, 7087.220405755363, 5735.598508104393, 5738.110592858114, 5743.167240750068, 5775.797847075332, 5777.566682498829, 5772.5670574707065, 5843.954615884407, 5856.832971800461, 5868.23712917318, 5870.911936320958, 6200.0, 6217.533684973645, 6254.437100660963, 6257.843553911098, 6282.905756413657, 6747.763828265987, 6788.558743681645, 6816.488763342769, 6822.897656535156, 6831.599522097958, 2002.6081873098349, 2027.807358300959, 2028.239410221167, 2039.7246371739923, 2044.9079791409124, 1457.1694134343534, 1513.8107736532934, 1538.130956009851, 1544.4980381375874, 1553.2662513975486, 6068.4538391544975, 6104.9316369635135, 6113.786017489367, 6297.244330680348, 6329.493640508748, 6613.4709223262025, 6641.966790166115, 6716.29478904708, 6736.2253340865445, 6774.9675097471545, 6132.540059495555, 6143.170671959318, 6204.627722336674, 6242.469390101802, 6262.342454042351, 3484.686378225972, 3586.3903136466865, 3597.4603809428795, 3644.0, 3664.7434679572175, 7120.585237152998, 7155.391791697764, 7174.713011479586, 7206.819829504199, 7206.819829504304, 6957.1651401831095, 6999.8600027999155, 7011.509194356346, 7012.1935977363255, 7016.0, 7005.404540614003, 7040.718371265092, 7086.0, 7093.432525397852, 7135.82160445993, 6731.865362692816, 6769.323067693192, 6770.830729231611, 6809.684707199576, 6835.248122706399, 6682.732690692318, 6686.632235227109, 6689.397954184147, 6771.39057484809, 6832.658367081725, 6958.686859091455, 7066.152061752417, 7068.71725130989, 7179.928200717926, 7182.389496892613, 5638.971805140948, 5687.260656114679, 5694.971525142348, 5722.885542289214, 5782.2483077199695, 6539.313372095861, 6701.860683683688, 6868.347506986828, 6907.827304317432, 6940.930590694028, 6630.9336906630315, 6636.104125943129, 6638.0, 6692.130023097161, 6711.3288671132495, 6605.702743376656, 6615.338466153538, 6656.36764507371, 6663.433608143362, 6676.126427707703, 6593.241777195684, 6593.472522198117, 6593.736250549924, 6595.769148079986, 6602.66986650656, 6556.18047744032, 6605.0, 6729.629870357177, 6737.966310168418, 6777.322267773183, 6538.1500404947055, 6545.541812073109, 6547.672616369067, 6560.737570497317, 6567.343265673395], "value": 5377.51609979115, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [988.63914671145, 996.5981983419957, 1004.7488127968008, 1025.897410258974, 1027.9434631095287, 19836.404907852753, 20585.27951521697, 20901.477463063395, 20911.16355345788, 20920.26779062733, 19514.121864516095, 19667.31164409246, 19733.70399444006, 19764.30824921128, 19766.604667906635, 1020.8825985011725, 1048.1981284317503, 1048.4705223861938, 1048.4757621189406, 1048.4967215736451, 1050.4170185547018, 1050.679542739464, 1050.7320633238514, 1051.47951763877, 1056.5668076088805, 1084.8752393474772, 1117.357519426329, 1119.5969450997675, 1120.8262719278484, 1131.2590253384046, 1117.4245263689206, 1119.3843386137632, 1122.6183097746723, 1124.2130508643982, 1128.266626692648, 818.4475479051675, 819.1399031017468, 820.7948012996751, 821.4455242711146, 825.7564018614463, 19237.80762192374, 19367.51581210467, 19612.0, 19790.80209197904, 19821.603567928705, 21276.255331063494, 21704.674429883566, 22054.779452205432, 22068.668969965463, 22079.779202207934, 18498.44504664849, 18638.813611863978, 18691.626167476574, 18723.0, 18840.34058807949, 3860.652541271299, 3889.611038896116, 3897.688184945226, 4081.1429599784083, 4086.6322031017353, 128581.0, 139936.93118313883, 159973.0, 160097.0, 164196.17901910533, 18234.544136396697, 18287.542811429554, 18386.448406547825, 18477.445676629453, 18521.35175268886, 33271.33457330888, 34058.318833623685, 34203.486947695805, 34262.82868585641, 34272.657273427445, 9124.908750912406, 9554.331196816294, 9636.807263854684, 9649.807003859883, 9650.08324209199, 4504.842330518416, 4601.171789077931, 4615.492295847454, 4644.164050470948, 4675.275332323427, 6306.306306306303, 6339.683015849189, 6343.524235682342, 6426.389492998158, 6429.517786166056, 1216.5766053717173, 1220.6216073017392, 1223.5228260978226, 1230.8830661087181, 1246.6447062587301, 726.4007194064917, 744.6053591596462, 745.2547452547452, 752.0449029732209, 760.2511526146741, 13324.267165305808, 13359.034026785928, 13387.263700496565, 13826.65433364174, 13867.0, 743.5204293230836, 747.3572727454385, 753.886916962449, 759.5215014540804, 761.2919984414548, 6517.967410162919, 6633.2040155181685, 6670.132882725215, 6713.26154123046, 6762.357576030269, 154278.22860885624, 159699.0, 159999.0, 160599.0, 161254.1937290306, 113592.0, 132093.0, 138009.0, 139589.0, 141180.2940985309, 120802.3959880195, 121316.0, 122747.3862630699, 123376.0, 124169.0, 13771.586852394445, 14146.575602731522, 14372.137671739729, 14401.135931844123, 14578.85421145775, 52414.47585524096, 53859.19211211757, 54444.0, 54993.45006550043, 55289.0, 70332.0, 70596.29403705898, 72182.63908680424, 73014.63492682502, 73930.2606973945, 19196.0, 19480.0, 19568.706469403256, 19597.216111355385, 19876.304329348404, 20506.0, 20523.794762052188, 20554.486137846674, 20768.273110441063, 20862.582748345252, 19127.23491060342, 19389.806101939364, 19448.708269376253, 19460.708089378386, 19464.0, 20113.899430502755, 20227.089780960185, 20386.49033774108, 20443.080061396977, 20475.38573842787, 18949.43151705451, 18980.335688250845, 19064.904675476533, 19080.0, 19175.232990680775, 15010.699786004438, 15060.623484412978, 15127.243637818285, 15260.465883694018, 15358.769618455508, 14123.788143177655, 14220.075695079786, 14245.28773561297, 14271.57185284443, 14293.0], "value": 10230.258684115484, "unit": "score"}]}, {"extraOptions": ["e10s", "stylo_disabled"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1374.8999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 105.0, 106.0, 106.0, 105.0, 107.0, 106.0, 105.0, 105.0, 105.0], "value": 105.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 122.0, 111.0, 112.0, 112.0, 112.0, 144.0, 113.0, 137.0, 117.0], "value": 119.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 161.0, 163.0, 161.0, 163.0, 162.0, 162.0, 162.0, 169.0, 165.0], "value": 163.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 73.0, 73.0, 72.0, 76.0, 74.0, 76.0, 74.0, 72.0], "value": 73.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 78.0, 79.0, 77.0, 78.0, 78.0, 78.0, 78.0, 78.0, 80.0], "value": 78.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 113.0, 113.0, 114.0, 114.0, 113.0, 113.0, 113.0, 114.0], "value": 113.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 150.0, 150.0, 149.0, 150.0, 149.0, 151.0, 150.0, 151.0, 151.0], "value": 150.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 98.0, 94.0, 94.0, 94.0, 94.0, 99.0, 94.0, 96.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [43.0, 44.0, 53.0, 49.0, 44.0, 45.0, 44.0, 44.0, 42.0, 45.0], "value": 45.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [37.0, 37.0, 36.0, 37.0, 37.0, 39.0, 37.0, 37.0, 36.0, 37.0], "value": 37.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 70.0, 70.0, 71.0, 71.0, 71.0, 72.0, 68.0, 69.0, 75.0], "value": 70.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 108.0, 109.0, 106.0, 111.0, 116.0, 106.0, 112.0, 111.0, 108.0], "value": 110.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 147.0, 152.0, 150.0, 149.0, 156.0, 152.0, 156.0, 150.0, 150.0], "value": 151.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 64.0, 62.0, 61.0, 64.0, 62.0, 58.0, 60.0, 60.0, 60.0], "value": 61.6, "unit": "score"}]}]} 12:18:03 INFO - Return code: 0 12:18:03 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 12:18:03 INFO - # TBPL SUCCESS # 12:18:03 INFO - Running post-action listener: _package_coverage_data 12:18:03 INFO - Running post-action listener: _resource_record_post_action 12:18:03 INFO - [mozharness: 2017-09-27 19:18:03.897651Z] Finished run-tests step (success) 12:18:03 INFO - Running post-run listener: _resource_record_post_run 12:18:03 INFO - Total resource usage - Wall time: 1187s; CPU: 13.0%; Read bytes: 40960; Write bytes: 330895360; Read time: 584; Write time: 488968 12:18:03 INFO - TinderboxPrint: CPU usage
13.2% 12:18:03 INFO - TinderboxPrint: I/O read bytes / time
40,960 / 584 12:18:03 INFO - TinderboxPrint: I/O write bytes / time
330,895,360 / 488,968 12:18:03 INFO - TinderboxPrint: CPU idle
8,218.9 (86.8%) 12:18:03 INFO - TinderboxPrint: CPU user
1,189.1 (12.6%) 12:18:03 INFO - TinderboxPrint: Swap in / out
0 / 0 12:18:03 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 13189120; Read time: 0; Write time: 2472 12:18:03 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 12:18:03 INFO - run-tests - Wall time: 1170s; CPU: 13.0%; Read bytes: 40960; Write bytes: 317706240; Read time: 584; Write time: 486496 12:18:04 INFO - Running post-run listener: _upload_blobber_files 12:18:04 INFO - Blob upload gear active. 12:18:04 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:18: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 12:18:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 12:18:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 12:18:04 INFO - (blobuploader) - INFO - Open directory for files ... 12:18:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 12:18:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:18:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:18:05 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 12:18:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:18:05 INFO - (blobuploader) - INFO - Done attempting. 12:18:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log ... 12:18:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:18:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:18:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_errorsummary.log: uploaded 12:18:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:18:06 INFO - (blobuploader) - INFO - Done attempting. 12:18:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 12:18:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:18:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:18:13 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 12:18:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:18:13 INFO - (blobuploader) - INFO - Done attempting. 12:18:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log ... 12:18:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:18:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:18:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_raw.log: uploaded 12:18:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:18:14 INFO - (blobuploader) - INFO - Done attempting. 12:18:14 INFO - (blobuploader) - INFO - Iteration through files over. 12:18:14 INFO - Return code: 0 12:18:14 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:18:14 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:18:14 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8e9fbf2c0869e2e9e4f092f10fb17e9723b1420d9d4fad86a09bd5df2de7566badea8e5c6a5288cbe63b898534999944bfbc9cebeb4f4afe657f8e95443c71ec", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/75d8e67a86f3c7ca88072392bc811300a9ebd25dd7c488b74c116550a0748e58ec2c1bb758ba8d28388a432a3530690dbe9465fe0ffa5a60bc93101dd36629c3", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2958b847dee506bef67737e124d123cdf9f912a01dc3a19735d1b03d21a400094753a354a39a26b5e4ff3222f2318a84250add5c64c3481a8b91ec90920db731", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9dde7273256212699ed2202aaa7d5441c49a375eee931b97b4b6b702042a8c13289ddfab7a9c30bc6982b838b45a629a646bbe7f96f8da1c607bd09bbef161b9"} 12:18:14 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:18:14 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:18:14 INFO - Contents: 12:18:14 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8e9fbf2c0869e2e9e4f092f10fb17e9723b1420d9d4fad86a09bd5df2de7566badea8e5c6a5288cbe63b898534999944bfbc9cebeb4f4afe657f8e95443c71ec", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/75d8e67a86f3c7ca88072392bc811300a9ebd25dd7c488b74c116550a0748e58ec2c1bb758ba8d28388a432a3530690dbe9465fe0ffa5a60bc93101dd36629c3", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2958b847dee506bef67737e124d123cdf9f912a01dc3a19735d1b03d21a400094753a354a39a26b5e4ff3222f2318a84250add5c64c3481a8b91ec90920db731", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9dde7273256212699ed2202aaa7d5441c49a375eee931b97b4b6b702042a8c13289ddfab7a9c30bc6982b838b45a629a646bbe7f96f8da1c607bd09bbef161b9"} 12:18:14 INFO - Running post-run listener: copy_logs_to_upload_dir 12:18:14 INFO - Copying logs to upload dir... 12:18:14 INFO - mkdir: /builds/slave/test/build/upload/logs 12:18:14 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1244.304346 ========= master_lag: 0.21 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2017-09-27 12:18:14.285882) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-27 12:18:14.288643) ========= 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=ba164b0a7b0ec7655860e956000001c1-1506538647.591657-324272956 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8e9fbf2c0869e2e9e4f092f10fb17e9723b1420d9d4fad86a09bd5df2de7566badea8e5c6a5288cbe63b898534999944bfbc9cebeb4f4afe657f8e95443c71ec", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/75d8e67a86f3c7ca88072392bc811300a9ebd25dd7c488b74c116550a0748e58ec2c1bb758ba8d28388a432a3530690dbe9465fe0ffa5a60bc93101dd36629c3", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2958b847dee506bef67737e124d123cdf9f912a01dc3a19735d1b03d21a400094753a354a39a26b5e4ff3222f2318a84250add5c64c3481a8b91ec90920db731", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9dde7273256212699ed2202aaa7d5441c49a375eee931b97b4b6b702042a8c13289ddfab7a9c30bc6982b838b45a629a646bbe7f96f8da1c607bd09bbef161b9"} build_url:https://queue.taskcluster.net/v1/task/PBHu4AnVT_OJapiiUJnugg/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011255 build_url: 'https://queue.taskcluster.net/v1/task/PBHu4AnVT_OJapiiUJnugg/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8e9fbf2c0869e2e9e4f092f10fb17e9723b1420d9d4fad86a09bd5df2de7566badea8e5c6a5288cbe63b898534999944bfbc9cebeb4f4afe657f8e95443c71ec", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/75d8e67a86f3c7ca88072392bc811300a9ebd25dd7c488b74c116550a0748e58ec2c1bb758ba8d28388a432a3530690dbe9465fe0ffa5a60bc93101dd36629c3", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2958b847dee506bef67737e124d123cdf9f912a01dc3a19735d1b03d21a400094753a354a39a26b5e4ff3222f2318a84250add5c64c3481a8b91ec90920db731", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9dde7273256212699ed2202aaa7d5441c49a375eee931b97b4b6b702042a8c13289ddfab7a9c30bc6982b838b45a629a646bbe7f96f8da1c607bd09bbef161b9"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-27 12:18:14.320978) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-27 12:18:14.321365) ========= 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=ba164b0a7b0ec7655860e956000001c1-1506538647.591657-324272956 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004498 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-27 12:18:14.371972) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-27 12:18:14.372307) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-27 12:18:14.372629) ========= ========= Total master_lag: 0.35 =========