builder: mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s slave: talos-linux64-ix-076 starttime: 1506990573.45 results: success (0) revision: 65dac33a5682f3ec5a675e7f3314b0c1520a13fa ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-10-02 17:29:33.454721) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-10-02 17:29:33.455192) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-10-02 17:29:33.455459) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-10-02 17:29:33.505243) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-10-02 17:29:33.505545) ========= 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=9bfb7e13875ed353a705960e000001c0-1506988797.877462-1087527954 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-10-02 17:29:33-- 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% 1.69M=0.007s 2017-10-02 17:29:33 (1.69 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.344883 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-10-02 17:29:33.877237) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-10-02 17:29:33.877583) ========= 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=9bfb7e13875ed353a705960e000001c0-1506988797.877462-1087527954 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017675 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-10-02 17:29:33.933791) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-10-02 17:29:33.934147) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 65dac33a5682f3ec5a675e7f3314b0c1520a13fa --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 65dac33a5682f3ec5a675e7f3314b0c1520a13fa --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=9bfb7e13875ed353a705960e000001c0-1506988797.877462-1087527954 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-10-02 17:29:33,983 truncating revision to first 12 chars 2017-10-02 17:29:33,984 Setting DEBUG logging. 2017-10-02 17:29:33,984 attempt 1/10 2017-10-02 17:29:33,984 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/65dac33a5682?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-10-02 17:29:34,358 unpacking tar archive at: mozilla-central-65dac33a5682/testing/mozharness/ program finished with exit code 0 elapsedTime=0.636161 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-10-02 17:29:34.594724) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-10-02 17:29:34.595041) ========= script_repo_revision: 65dac33a5682f3ec5a675e7f3314b0c1520a13fa ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-10-02 17:29:34.595421) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-10-02 17:29:34.595690) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-10-02 17:29:34.609555) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2017-10-02 17:29:34.609904) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-stylo-disabled-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-stylo-disabled-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=9bfb7e13875ed353a705960e000001c0-1506988797.877462-1087527954 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:29:34 INFO - MultiFileLogger online at 20171002 17:29:34 in /builds/slave/test 17:29:34 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-stylo-disabled-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 17:29:34 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:29:34 INFO - {'append_to_log': False, 17:29:34 INFO - 'base_work_dir': '/builds/slave/test', 17:29:34 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 17:29:34 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:29:34 INFO - 'branch': 'Firefox-Non-PGO', 17:29:34 INFO - 'buildbot_json_path': 'buildprops.json', 17:29:34 INFO - 'code_coverage': False, 17:29:34 INFO - 'config_files': ('talos/linux_config.py',), 17:29:34 INFO - 'default_actions': ('clobber', 17:29:34 INFO - 'read-buildbot-config', 17:29:34 INFO - 'download-and-extract', 17:29:34 INFO - 'populate-webroot', 17:29:34 INFO - 'create-virtualenv', 17:29:34 INFO - 'install', 17:29:34 INFO - 'setup-mitmproxy', 17:29:34 INFO - 'run-tests'), 17:29:34 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:29:34 INFO - 'disable_ccov_upload': False, 17:29:34 INFO - 'disable_stylo': False, 17:29:34 INFO - 'download_minidump_stackwalk': True, 17:29:34 INFO - 'download_symbols': 'ondemand', 17:29:34 INFO - 'enable_stylo': False, 17:29:34 INFO - 'enable_webrender': False, 17:29:34 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 17:29:34 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:29:34 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:29:34 INFO - 'gecko_profile': False, 17:29:34 INFO - 'gecko_profile_interval': 0, 17:29:34 INFO - 'installer_path': 'installer.exe', 17:29:34 INFO - 'log_level': 'info', 17:29:34 INFO - 'log_name': 'talos', 17:29:34 INFO - 'log_to_console': True, 17:29:34 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:29:34 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:29:34 INFO - 'opt_config_files': (), 17:29:34 INFO - 'pip_index': False, 17:29:34 INFO - 'suite': 'dromaeojs-stylo-disabled-e10s', 17:29:34 INFO - 'system_bits': '32', 17:29:34 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:29:34 INFO - 'title': 'talos-linux64-ix-076', 17:29:34 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:29:34 INFO - 'use_talos_json': True, 17:29:34 INFO - 'verify': 'False', 17:29:34 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:29:34 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:29:34 INFO - 'work_dir': 'build'} 17:29:34 INFO - [mozharness: 2017-10-03 00:29:34.794851Z] Running clobber step. 17:29:34 INFO - Running pre-action listener: _resource_record_pre_action 17:29:34 INFO - Running main action method: clobber 17:29:34 INFO - rmtree: /builds/slave/test/build 17:29:34 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:29:35 INFO - Running post-action listener: _resource_record_post_action 17:29:35 INFO - [mozharness: 2017-10-03 00:29:35.786577Z] Finished clobber step (success) 17:29:35 INFO - [mozharness: 2017-10-03 00:29:35.786673Z] Running read-buildbot-config step. 17:29:35 INFO - Running pre-action listener: _resource_record_pre_action 17:29:35 INFO - Running main action method: read_buildbot_config 17:29:35 INFO - Using buildbot properties: 17:29:35 INFO - { 17:29:35 INFO - "project": "", 17:29:35 INFO - "product": "firefox", 17:29:35 INFO - "who": "kwierso@gmail.com", 17:29:35 INFO - "installer_path": "public/build/target.tar.bz2", 17:29:35 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s", 17:29:35 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 17:29:35 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-stylo-disabled-e10s", 17:29:35 INFO - "stage_platform": "linux64", 17:29:35 INFO - "basedir": "/builds/slave/test", 17:29:35 INFO - "buildnumber": 91, 17:29:35 INFO - "platform": "ubuntu64_hw", 17:29:35 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 17:29:35 INFO - "slavebuilddir": "test", 17:29:35 INFO - "taskId": "bV554n8LQziNNNe13GGnsg", 17:29:35 INFO - "branch": "mozilla-central", 17:29:35 INFO - "script_repo_revision": "production", 17:29:35 INFO - "revision": "65dac33a5682f3ec5a675e7f3314b0c1520a13fa", 17:29:35 INFO - "slavename": "talos-linux64-ix-076", 17:29:35 INFO - "repo_path": "mozilla-central" 17:29:35 INFO - } 17:29:35 INFO - Finding installer, test and symbols from parent task. 17:29:35 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bV554n8LQziNNNe13GGnsg'}, attempt #1 17:29:36 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bV554n8LQziNNNe13GGnsg'}, attempt #1 17:29:36 INFO - Task dependencies: Hy3hXRK2T5ipTB-nz_T5Yw 17:29:36 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Hy3hXRK2T5ipTB-nz_T5Yw'}, attempt #1 17:29:37 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/Hy3hXRK2T5ipTB-nz_T5Yw/artifacts/public/build/target.tar.bz2 17:29:37 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/Hy3hXRK2T5ipTB-nz_T5Yw/artifacts/public/build/target.test_packages.json 17:29:37 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/Hy3hXRK2T5ipTB-nz_T5Yw/artifacts/public/build/target.crashreporter-symbols.zip 17:29:37 INFO - Running post-action listener: _resource_record_post_action 17:29:37 INFO - [mozharness: 2017-10-03 00:29:37.442643Z] Finished read-buildbot-config step (success) 17:29:37 INFO - [mozharness: 2017-10-03 00:29:37.442860Z] Running download-and-extract step. 17:29:37 INFO - Running pre-action listener: _resource_record_pre_action 17:29:37 INFO - Running main action method: download_and_extract 17:29:37 INFO - mkdir: /builds/slave/test/build/tests 17:29:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:29:37 INFO - trying https://queue.taskcluster.net/v1/task/Hy3hXRK2T5ipTB-nz_T5Yw/artifacts/public/build/target.test_packages.json 17:29:37 INFO - Downloading https://queue.taskcluster.net/v1/task/Hy3hXRK2T5ipTB-nz_T5Yw/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 17:29:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Hy3hXRK2T5ipTB-nz_T5Yw/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 17:29:38 INFO - Downloaded 989 bytes. 17:29:38 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 17:29:38 INFO - Using the following test package requirements: 17:29:38 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 17:29:38 INFO - u'common': [u'target.common.tests.zip'], 17:29:38 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 17:29:38 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 17:29:38 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 17:29:38 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 17:29:38 INFO - u'mozbase': [u'target.common.tests.zip'], 17:29:38 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 17:29:38 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 17:29:38 INFO - u'web-platform': [u'target.common.tests.zip', 17:29:38 INFO - u'target.web-platform.tests.tar.gz'], 17:29:38 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 17:29:38 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 17:29:38 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Hy3hXRK2T5ipTB-nz_T5Yw/artifacts/public/build/target.common.tests.zip 17:29:38 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Hy3hXRK2T5ipTB-nz_T5Yw/artifacts/public/build/target.common.tests.zip'}, attempt #1 17:29:38 INFO - Fetch https://queue.taskcluster.net/v1/task/Hy3hXRK2T5ipTB-nz_T5Yw/artifacts/public/build/target.common.tests.zip into memory 17:29:39 INFO - Content-Length response header: 55346447 17:29:39 INFO - Bytes received: 55346447 17:29:50 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Hy3hXRK2T5ipTB-nz_T5Yw/artifacts/public/build/target.talos.tests.zip 17:29:50 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Hy3hXRK2T5ipTB-nz_T5Yw/artifacts/public/build/target.talos.tests.zip'}, attempt #1 17:29:50 INFO - Fetch https://queue.taskcluster.net/v1/task/Hy3hXRK2T5ipTB-nz_T5Yw/artifacts/public/build/target.talos.tests.zip into memory 17:29:51 INFO - Content-Length response header: 14522427 17:29:51 INFO - Bytes received: 14522427 17:29: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')]} 17:29:51 INFO - trying https://queue.taskcluster.net/v1/task/Hy3hXRK2T5ipTB-nz_T5Yw/artifacts/public/build/target.tar.bz2 17:29:51 INFO - Downloading https://queue.taskcluster.net/v1/task/Hy3hXRK2T5ipTB-nz_T5Yw/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 17:29:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Hy3hXRK2T5ipTB-nz_T5Yw/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 17:29:53 INFO - Downloaded 61637688 bytes. 17:29:53 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Hy3hXRK2T5ipTB-nz_T5Yw/artifacts/public/build/target.tar.bz2 17:29:53 INFO - mkdir: /builds/slave/test/properties 17:29:53 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:29:53 INFO - Writing to file /builds/slave/test/properties/build_url 17:29:53 INFO - Contents: 17:29:53 INFO - build_url:https://queue.taskcluster.net/v1/task/Hy3hXRK2T5ipTB-nz_T5Yw/artifacts/public/build/target.tar.bz2 17:29:53 INFO - Running post-action listener: _resource_record_post_action 17:29:53 INFO - Running post-action listener: find_tests_for_verification 17:29:53 INFO - Running post-action listener: set_extra_try_arguments 17:29:53 INFO - [mozharness: 2017-10-03 00:29:53.107387Z] Finished download-and-extract step (success) 17:29:53 INFO - [mozharness: 2017-10-03 00:29:53.107522Z] Running populate-webroot step. 17:29:53 INFO - Running pre-action listener: _resource_record_pre_action 17:29:53 INFO - Running main action method: populate_webroot 17:29:53 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:29:53 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 17:29:53 INFO - 'tests': ['tresize', 17:29:53 INFO - 'tcanvasmark']}, 17:29:53 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:29:53 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 17:29:53 INFO - 'tests': ['dromaeo_css', 17:29:53 INFO - 'kraken']}, 17:29:53 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 17:29:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:29:53 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 17:29:53 INFO - 'talos_options': ['--disable-stylo'], 17:29:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:29:53 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 17:29:53 INFO - 'tests': ['damp', 'tps']}, 17:29:53 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 17:29:53 INFO - 'talos_options': ['--disable-stylo'], 17:29:53 INFO - 'tests': ['damp', 'tps']}, 17:29:53 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:29:53 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 17:29:53 INFO - 'tests': ['dromaeo_dom']}, 17:29:53 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 17:29:53 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 17:29:53 INFO - 'tests': ['basic_compositor_video', 17:29:53 INFO - 'glvideo']}, 17:29:53 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 17:29:53 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 17:29:53 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 17:29:53 INFO - 'talos_options': ['--disable-stylo'], 17:29:53 INFO - 'tests': ['ts_paint_webext', 17:29:53 INFO - 'tp5o_webext']}, 17:29:53 INFO - 'other-e10s': {'tests': ['a11yr', 17:29:53 INFO - 'ts_paint', 17:29:53 INFO - 'tpaint', 17:29:53 INFO - 'sessionrestore', 17:29:53 INFO - 'sessionrestore_many_windows', 17:29:53 INFO - 'sessionrestore_no_auto_restore', 17:29:53 INFO - 'tabpaint', 17:29:53 INFO - 'cpstartup']}, 17:29:53 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 17:29:53 INFO - 'tests': ['a11yr', 17:29:53 INFO - 'ts_paint', 17:29:53 INFO - 'tpaint', 17:29:53 INFO - 'sessionrestore', 17:29:53 INFO - 'sessionrestore_many_windows', 17:29:53 INFO - 'sessionrestore_no_auto_restore', 17:29:53 INFO - 'tabpaint', 17:29:53 INFO - 'cpstartup']}, 17:29:53 INFO - 'perf-reftest-e10s': {'tests': ['perf_reftest']}, 17:29:53 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 17:29:53 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 17:29:53 INFO - 'tests': ['perf_reftest_singletons']}, 17:29:53 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 17:29:53 INFO - 'tests': ['perf_reftest']}, 17:29:53 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:29:53 INFO - 'tsvgr_opacity', 17:29:53 INFO - 'tart', 17:29:53 INFO - 'tscrollx', 17:29:53 INFO - 'tsvg_static']}, 17:29:53 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 17:29:53 INFO - 'tests': ['tsvgx', 17:29:53 INFO - 'tsvgr_opacity', 17:29:53 INFO - 'tart', 17:29:53 INFO - 'tscrollx', 17:29:53 INFO - 'tsvg_static']}, 17:29:53 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 17:29:53 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 17:29:53 INFO - 'talos_options': ['--disable-stylo'], 17:29:53 INFO - 'tests': ['tp5o']}, 17:29:53 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 17:29:53 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 17:29:53 INFO - 'talos_options': ['--mitmproxy', 17:29:53 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 17:29:53 INFO - '--firstNonBlankPaint'], 17:29:53 INFO - 'tests': ['tp6_google', 17:29:53 INFO - 'tp6_youtube', 17:29:53 INFO - 'tp6_amazon', 17:29:53 INFO - 'tp6_facebook']}, 17:29:53 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 17:29:53 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 17:29:53 INFO - 'talos_options': ['--disable-stylo', 17:29:53 INFO - '--mitmproxy', 17:29:53 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 17:29:53 INFO - '--firstNonBlankPaint'], 17:29:53 INFO - 'tests': ['tp6_google', 17:29:53 INFO - 'tp6_youtube', 17:29:53 INFO - 'tp6_amazon', 17:29:53 INFO - 'tp6_facebook']}, 17:29:53 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 17:29:53 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 17:29:53 INFO - 'talos_options': ['--stylo-threads=1', 17:29:53 INFO - '--mitmproxy', 17:29:53 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 17:29:53 INFO - '--firstNonBlankPaint'], 17:29:53 INFO - 'tests': ['tp6_google', 17:29:53 INFO - 'tp6_youtube', 17:29:53 INFO - 'tp6_amazon', 17:29:53 INFO - 'tp6_facebook']}, 17:29:53 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 17:29:53 INFO - 'talos_options': ['--xperf_path', 17:29:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:29:53 INFO - 'tests': ['tp5n']}, 17:29:53 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 17:29:53 INFO - 'talos_options': ['--disable-stylo', 17:29:53 INFO - '--xperf_path', 17:29:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:29:53 INFO - 'tests': ['tp5n']}}} 17:29:53 INFO - Running post-action listener: _resource_record_post_action 17:29:53 INFO - [mozharness: 2017-10-03 00:29:53.583862Z] Finished populate-webroot step (success) 17:29:53 INFO - [mozharness: 2017-10-03 00:29:53.583959Z] Running create-virtualenv step. 17:29:53 INFO - Running pre-action listener: _resource_record_pre_action 17:29:53 INFO - Running main action method: create_virtualenv 17:29:53 INFO - Creating virtualenv /builds/slave/test/build/venv 17:29:53 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 17:29:53 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 17:29:53 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 17:29:53 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:29:53 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:29:54 INFO - Installing distribute.............................................................................................................................................................................................done. 17:29:54 INFO - Installing pip...............done. 17:29:54 INFO - Return code: 0 17:29:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 17:29:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 17:29:54 INFO - Reading from file tmpfile_stdout 17:29:54 INFO - Output received: 17:29:54 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 17:29:54 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:29:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:29:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:29:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:29:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:29:54 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 0x184e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a16b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bbb9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bb8d60>, '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 0x1bb9a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bb9ef0>, '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': '9bfb7e13875ed353a705960e000001c0-1506988797.877462-1087527954', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:29:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 17:29:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 17:29:54 INFO - Using env: {'DISPLAY': ':0', 17:29:54 INFO - 'HOME': '/home/cltbld', 17:29:54 INFO - 'LANG': 'en_US.UTF-8', 17:29:54 INFO - 'LANGUAGE': 'en_US:en', 17:29:54 INFO - 'LOGNAME': 'cltbld', 17:29:54 INFO - 'MAIL': '/var/mail/cltbld', 17:29:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:29:54 INFO - 'MOZ_NO_REMOTE': '1', 17:29:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:29:54 INFO - 'NO_EM_RESTART': '1', 17:29:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:29:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:29:54 INFO - 'PWD': '/builds/slave/test', 17:29:54 INFO - 'SHELL': '/bin/bash', 17:29:54 INFO - 'SHLVL': '1', 17:29:54 INFO - 'TERM': 'linux', 17:29:54 INFO - 'TMOUT': '86400', 17:29:54 INFO - 'USER': 'cltbld', 17:29:54 INFO - 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1506988797.877462-1087527954', 17:29:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:29:54 INFO - '_': '/tools/buildbot/bin/python'} 17:29:55 INFO - Ignoring indexes: http://pypi.python.org/simple/ 17:29:55 INFO - Downloading/unpacking pip>=1.5 17:29:55 INFO - Running setup.py egg_info for package pip 17:29:55 INFO - warning: no files found matching 'pip/cacert.pem' 17:29:55 INFO - warning: no files found matching '*.html' under directory 'docs' 17:29:55 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 17:29:55 INFO - no previously-included directories found matching 'docs/_build/_sources' 17:29:55 INFO - Installing collected packages: pip 17:29:55 INFO - Found existing installation: pip 1.1 17:29:55 INFO - Uninstalling pip: 17:29:55 INFO - Successfully uninstalled pip 17:29:55 INFO - Running setup.py install for pip 17:29:55 INFO - warning: no files found matching 'pip/cacert.pem' 17:29:55 INFO - warning: no files found matching '*.html' under directory 'docs' 17:29:55 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 17:29:55 INFO - no previously-included directories found matching 'docs/_build/_sources' 17:29:55 INFO - Installing pip script to /builds/slave/test/build/venv/bin 17:29:55 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 17:29:55 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 17:29:55 INFO - Successfully installed pip 17:29:55 INFO - Cleaning up... 17:29:55 INFO - Return code: 0 17:29:55 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 17:29:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:29:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:29:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:29:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:29:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x184e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a16b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bbb9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bb8d60>, '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 0x1bb9a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bb9ef0>, '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': '9bfb7e13875ed353a705960e000001c0-1506988797.877462-1087527954', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:29:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 17:29:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 17:29:55 INFO - Using env: {'DISPLAY': ':0', 17:29:55 INFO - 'HOME': '/home/cltbld', 17:29:55 INFO - 'LANG': 'en_US.UTF-8', 17:29:55 INFO - 'LANGUAGE': 'en_US:en', 17:29:55 INFO - 'LOGNAME': 'cltbld', 17:29:55 INFO - 'MAIL': '/var/mail/cltbld', 17:29:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:29:55 INFO - 'MOZ_NO_REMOTE': '1', 17:29:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:29:55 INFO - 'NO_EM_RESTART': '1', 17:29:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:29:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:29:55 INFO - 'PWD': '/builds/slave/test', 17:29:55 INFO - 'SHELL': '/bin/bash', 17:29:55 INFO - 'SHLVL': '1', 17:29:55 INFO - 'TERM': 'linux', 17:29:55 INFO - 'TMOUT': '86400', 17:29:55 INFO - 'USER': 'cltbld', 17:29:55 INFO - 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1506988797.877462-1087527954', 17:29:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:29:55 INFO - '_': '/tools/buildbot/bin/python'} 17:29:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:29:56 INFO - Downloading/unpacking psutil>=3.1.1 17:29:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:29:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:29:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:29:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:29:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:29:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:29:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:29:57 INFO - Installing collected packages: psutil 17:29:57 INFO - Running setup.py install for psutil 17:29:57 INFO - building 'psutil._psutil_linux' extension 17:29:57 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 17:29:57 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 17:29:57 INFO - building 'psutil._psutil_posix' extension 17:29:57 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 17:29:57 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 17:29:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:29:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:29:57 INFO - Successfully installed psutil 17:29:57 INFO - Cleaning up... 17:29:57 INFO - Return code: 0 17:29:57 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 17:29:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:29:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:29:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:29:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:29: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 0x184e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a16b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bbb9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bb8d60>, '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 0x1bb9a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bb9ef0>, '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': '9bfb7e13875ed353a705960e000001c0-1506988797.877462-1087527954', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:29: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 17:29: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 17:29:57 INFO - Using env: {'DISPLAY': ':0', 17:29:57 INFO - 'HOME': '/home/cltbld', 17:29:57 INFO - 'LANG': 'en_US.UTF-8', 17:29:57 INFO - 'LANGUAGE': 'en_US:en', 17:29:57 INFO - 'LOGNAME': 'cltbld', 17:29:57 INFO - 'MAIL': '/var/mail/cltbld', 17:29:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:29:57 INFO - 'MOZ_NO_REMOTE': '1', 17:29:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:29:57 INFO - 'NO_EM_RESTART': '1', 17:29:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:29:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:29:57 INFO - 'PWD': '/builds/slave/test', 17:29:57 INFO - 'SHELL': '/bin/bash', 17:29:57 INFO - 'SHLVL': '1', 17:29:57 INFO - 'TERM': 'linux', 17:29:57 INFO - 'TMOUT': '86400', 17:29:57 INFO - 'USER': 'cltbld', 17:29:57 INFO - 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1506988797.877462-1087527954', 17:29:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:29:57 INFO - '_': '/tools/buildbot/bin/python'} 17:29:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:29:57 INFO - Downloading/unpacking mozsystemmonitor==0.3 17:29:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:29:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:29:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:29:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:29:59 INFO - Downloading mozsystemmonitor-0.3.tar.gz 17:29:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:29:59 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 17:29:59 INFO - Installing collected packages: mozsystemmonitor 17:29:59 INFO - Running setup.py install for mozsystemmonitor 17:30:00 INFO - Successfully installed mozsystemmonitor 17:30:00 INFO - Cleaning up... 17:30:00 INFO - Return code: 0 17:30:00 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 17:30: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')]} 17:30:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:30: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')]} 17:30:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:30: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 0x184e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a16b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bbb9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bb8d60>, '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 0x1bb9a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bb9ef0>, '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': '9bfb7e13875ed353a705960e000001c0-1506988797.877462-1087527954', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:30: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 17:30: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 17:30:00 INFO - Using env: {'DISPLAY': ':0', 17:30:00 INFO - 'HOME': '/home/cltbld', 17:30:00 INFO - 'LANG': 'en_US.UTF-8', 17:30:00 INFO - 'LANGUAGE': 'en_US:en', 17:30:00 INFO - 'LOGNAME': 'cltbld', 17:30:00 INFO - 'MAIL': '/var/mail/cltbld', 17:30:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:30:00 INFO - 'MOZ_NO_REMOTE': '1', 17:30:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:30:00 INFO - 'NO_EM_RESTART': '1', 17:30:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:30:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:30:00 INFO - 'PWD': '/builds/slave/test', 17:30:00 INFO - 'SHELL': '/bin/bash', 17:30:00 INFO - 'SHLVL': '1', 17:30:00 INFO - 'TERM': 'linux', 17:30:00 INFO - 'TMOUT': '86400', 17:30:00 INFO - 'USER': 'cltbld', 17:30:00 INFO - 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1506988797.877462-1087527954', 17:30:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:30:00 INFO - '_': '/tools/buildbot/bin/python'} 17:30:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:30:00 INFO - Downloading/unpacking jsonschema==2.5.1 17:30:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:30:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:30:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:30:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:30:01 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:30:01 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 17:30:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:30:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:30:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:30:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:30:01 INFO - Downloading functools32-3.2.3-2.tar.gz 17:30:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:30:01 INFO - warning: no files found matching '*.txt' 17:30:01 INFO - no previously-included directories found matching 'build' 17:30:01 INFO - no previously-included directories found matching 'dist' 17:30:01 INFO - no previously-included directories found matching '.git*' 17:30:01 INFO - Installing collected packages: jsonschema, functools32 17:30:01 INFO - Running setup.py install for functools32 17:30:01 INFO - warning: no files found matching '*.txt' 17:30:01 INFO - no previously-included directories found matching 'build' 17:30:01 INFO - no previously-included directories found matching 'dist' 17:30:01 INFO - no previously-included directories found matching '.git*' 17:30:01 INFO - Successfully installed jsonschema functools32 17:30:01 INFO - Cleaning up... 17:30:01 INFO - Return code: 0 17:30:01 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 17:30:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:30:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:30:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:30:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:30:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x184e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a16b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bbb9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bb8d60>, '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 0x1bb9a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bb9ef0>, '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': '9bfb7e13875ed353a705960e000001c0-1506988797.877462-1087527954', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:30:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 17:30:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 17:30:01 INFO - Using env: {'DISPLAY': ':0', 17:30:01 INFO - 'HOME': '/home/cltbld', 17:30:01 INFO - 'LANG': 'en_US.UTF-8', 17:30:01 INFO - 'LANGUAGE': 'en_US:en', 17:30:01 INFO - 'LOGNAME': 'cltbld', 17:30:01 INFO - 'MAIL': '/var/mail/cltbld', 17:30:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:30:01 INFO - 'MOZ_NO_REMOTE': '1', 17:30:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:30:01 INFO - 'NO_EM_RESTART': '1', 17:30:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:30:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:30:01 INFO - 'PWD': '/builds/slave/test', 17:30:01 INFO - 'SHELL': '/bin/bash', 17:30:01 INFO - 'SHLVL': '1', 17:30:01 INFO - 'TERM': 'linux', 17:30:01 INFO - 'TMOUT': '86400', 17:30:01 INFO - 'USER': 'cltbld', 17:30:01 INFO - 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1506988797.877462-1087527954', 17:30:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:30:01 INFO - '_': '/tools/buildbot/bin/python'} 17:30:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:30:02 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 17:30:02 INFO - Cleaning up... 17:30:02 INFO - Return code: 0 17:30:02 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:30:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:30:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:30:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:30:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:30:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x184e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a16b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bbb9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bb8d60>, '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 0x1bb9a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bb9ef0>, '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': '9bfb7e13875ed353a705960e000001c0-1506988797.877462-1087527954', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:30:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 17:30:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 17:30:02 INFO - Using env: {'DISPLAY': ':0', 17:30:02 INFO - 'HOME': '/home/cltbld', 17:30:02 INFO - 'LANG': 'en_US.UTF-8', 17:30:02 INFO - 'LANGUAGE': 'en_US:en', 17:30:02 INFO - 'LOGNAME': 'cltbld', 17:30:02 INFO - 'MAIL': '/var/mail/cltbld', 17:30:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:30:02 INFO - 'MOZ_NO_REMOTE': '1', 17:30:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:30:02 INFO - 'NO_EM_RESTART': '1', 17:30:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:30:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:30:02 INFO - 'PWD': '/builds/slave/test', 17:30:02 INFO - 'SHELL': '/bin/bash', 17:30:02 INFO - 'SHLVL': '1', 17:30:02 INFO - 'TERM': 'linux', 17:30:02 INFO - 'TMOUT': '86400', 17:30:02 INFO - 'USER': 'cltbld', 17:30:02 INFO - 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1506988797.877462-1087527954', 17:30:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:30:02 INFO - '_': '/tools/buildbot/bin/python'} 17:30:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:30:02 INFO - Downloading/unpacking blobuploader==1.2.4 17:30: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 17:30: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 17:30: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 17:30: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 17:30:03 INFO - Downloading blobuploader-1.2.4.tar.gz 17:30:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:30:03 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:30: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 17:30: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 17:30: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 17:30: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 17:30:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:30:03 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:30: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 17:30: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 17:30: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 17:30: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 17:30:04 INFO - Downloading docopt-0.6.1.tar.gz 17:30:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:30:04 INFO - Installing collected packages: blobuploader, requests, docopt 17:30:04 INFO - Running setup.py install for blobuploader 17:30:04 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:30:04 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:30:04 INFO - Running setup.py install for requests 17:30:04 INFO - Running setup.py install for docopt 17:30:04 INFO - Successfully installed blobuploader requests docopt 17:30:04 INFO - Cleaning up... 17:30:04 INFO - Return code: 0 17:30:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:30: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')]} 17:30:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:30: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')]} 17:30:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:30:04 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 0x184e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a16b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bbb9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bb8d60>, '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 0x1bb9a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bb9ef0>, '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': '9bfb7e13875ed353a705960e000001c0-1506988797.877462-1087527954', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:30:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 17:30:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 17:30:04 INFO - Using env: {'DISPLAY': ':0', 17:30:04 INFO - 'HOME': '/home/cltbld', 17:30:04 INFO - 'LANG': 'en_US.UTF-8', 17:30:04 INFO - 'LANGUAGE': 'en_US:en', 17:30:04 INFO - 'LOGNAME': 'cltbld', 17:30:04 INFO - 'MAIL': '/var/mail/cltbld', 17:30:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:30:04 INFO - 'MOZ_NO_REMOTE': '1', 17:30:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:30:04 INFO - 'NO_EM_RESTART': '1', 17:30:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:30:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:30:04 INFO - 'PWD': '/builds/slave/test', 17:30:04 INFO - 'SHELL': '/bin/bash', 17:30:04 INFO - 'SHLVL': '1', 17:30:04 INFO - 'TERM': 'linux', 17:30:04 INFO - 'TMOUT': '86400', 17:30:04 INFO - 'USER': 'cltbld', 17:30:04 INFO - 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1506988797.877462-1087527954', 17:30:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:30:04 INFO - '_': '/tools/buildbot/bin/python'} 17:30:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:30:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:30:04 INFO - Running setup.py (path:/tmp/pip-mSNtfm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:30:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:30:04 INFO - Running setup.py (path:/tmp/pip-TkGcwJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:30:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:30:05 INFO - Running setup.py (path:/tmp/pip-qWbF0M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:30:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:30:05 INFO - Running setup.py (path:/tmp/pip-iJh5Z1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:30:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:30:05 INFO - Running setup.py (path:/tmp/pip-ZpUzzt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:30:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:30:05 INFO - Running setup.py (path:/tmp/pip-atFrke-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:30:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:30:05 INFO - Running setup.py (path:/tmp/pip-yrW08v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:30:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:30:05 INFO - Running setup.py (path:/tmp/pip-Rvqyg_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:30:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:30:05 INFO - Running setup.py (path:/tmp/pip-Jj1f0B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:30:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:30:05 INFO - Running setup.py (path:/tmp/pip-8178RE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:30:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:30:05 INFO - Running setup.py (path:/tmp/pip-L7quJ0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:30:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:30:05 INFO - Running setup.py (path:/tmp/pip-tetbtz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:30:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:30:05 INFO - Running setup.py (path:/tmp/pip-ldP8x4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:30:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:30:05 INFO - Running setup.py (path:/tmp/pip-h6Xe5u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:30:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:30:05 INFO - Running setup.py (path:/tmp/pip-sx9eHI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:30:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:30:05 INFO - Running setup.py (path:/tmp/pip-FuRbid-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:30:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:30:06 INFO - Running setup.py (path:/tmp/pip-vTlsFL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:30:06 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:30:06 INFO - Running setup.py install for manifestparser 17:30:06 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:30:06 INFO - Running setup.py install for mozcrash 17:30:06 INFO - Running setup.py install for mozdebug 17:30:06 INFO - Running setup.py install for mozdevice 17:30:06 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:30:06 INFO - Running setup.py install for mozfile 17:30:06 INFO - Running setup.py install for mozhttpd 17:30:06 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:30:06 INFO - Running setup.py install for mozinfo 17:30:06 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:30:06 INFO - Running setup.py install for mozInstall 17:30:06 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:30:06 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:30:06 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:30:06 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:30:06 INFO - Running setup.py install for mozleak 17:30:06 INFO - Running setup.py install for mozlog 17:30:07 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:30:07 INFO - Running setup.py install for moznetwork 17:30:07 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:30:07 INFO - Running setup.py install for mozprocess 17:30:07 INFO - Running setup.py install for mozprofile 17:30:07 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:30:07 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:30:07 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:30:07 INFO - Running setup.py install for mozrunner 17:30:07 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:30:07 INFO - Running setup.py install for mozscreenshot 17:30:07 INFO - Running setup.py install for moztest 17:30:07 INFO - Running setup.py install for mozversion 17:30:07 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:30:07 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:30:07 INFO - Cleaning up... 17:30:07 INFO - Return code: 0 17:30:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:30:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:30:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:30:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:30:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:30:07 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 0x184e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a16b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bbb9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bb8d60>, '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 0x1bb9a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bb9ef0>, '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': '9bfb7e13875ed353a705960e000001c0-1506988797.877462-1087527954', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:30:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 17:30:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 17:30:07 INFO - Using env: {'DISPLAY': ':0', 17:30:07 INFO - 'HOME': '/home/cltbld', 17:30:07 INFO - 'LANG': 'en_US.UTF-8', 17:30:07 INFO - 'LANGUAGE': 'en_US:en', 17:30:07 INFO - 'LOGNAME': 'cltbld', 17:30:07 INFO - 'MAIL': '/var/mail/cltbld', 17:30:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:30:07 INFO - 'MOZ_NO_REMOTE': '1', 17:30:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:30:07 INFO - 'NO_EM_RESTART': '1', 17:30:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:30:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:30:07 INFO - 'PWD': '/builds/slave/test', 17:30:07 INFO - 'SHELL': '/bin/bash', 17:30:07 INFO - 'SHLVL': '1', 17:30:07 INFO - 'TERM': 'linux', 17:30:07 INFO - 'TMOUT': '86400', 17:30:07 INFO - 'USER': 'cltbld', 17:30:07 INFO - 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1506988797.877462-1087527954', 17:30:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:30:07 INFO - '_': '/tools/buildbot/bin/python'} 17:30:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:30:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:30:08 INFO - Running setup.py (path:/tmp/pip-565f8v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:30:08 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 17:30:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:30:08 INFO - Running setup.py (path:/tmp/pip-UKzLlc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:30:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 17:30:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:30:08 INFO - Running setup.py (path:/tmp/pip-yYQhsM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:30:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 17:30:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:30:08 INFO - Running setup.py (path:/tmp/pip-PHFnFW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:30:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.51 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:30:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:30:08 INFO - Running setup.py (path:/tmp/pip-cAUQPX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:30:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 17:30:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:30:08 INFO - Running setup.py (path:/tmp/pip-QuZU5z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:30:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 17:30:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:30:08 INFO - Running setup.py (path:/tmp/pip-0D1MPA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:30:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.10 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 17:30:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:30:08 INFO - Running setup.py (path:/tmp/pip-eUoO80-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:30:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.13 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 17:30:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:30:08 INFO - Running setup.py (path:/tmp/pip-Dkc4Zc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:30:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 17:30:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:30:08 INFO - Running setup.py (path:/tmp/pip-2_5XhQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:30:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.5 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:30:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:30:08 INFO - Running setup.py (path:/tmp/pip-S_SGSo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:30:08 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 17:30:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:30:08 INFO - Running setup.py (path:/tmp/pip-MgHnkm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:30:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 17:30:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:30:08 INFO - Running setup.py (path:/tmp/pip-VR1pLm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:30:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 17:30:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:30:09 INFO - Running setup.py (path:/tmp/pip-brfVL_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:30:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 17:30:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:30:09 INFO - Running setup.py (path:/tmp/pip-fZjGii-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:30:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 17:30:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:30:09 INFO - Running setup.py (path:/tmp/pip-9zVifs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:30:09 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 17:30:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:30:09 INFO - Running setup.py (path:/tmp/pip-uMfXKJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:30:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 17:30:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 17:30:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 17:30:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 17:30:09 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:30:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:30:09 INFO - Requirement already satisfied (use --upgrade to upgrade): requests in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozInstall==1.13->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 17:30:09 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:30:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:30:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:30:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:30:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:30:10 INFO - Downloading blessings-1.6.tar.gz 17:30:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:30:10 INFO - Installing collected packages: blessings 17:30:10 INFO - Running setup.py install for blessings 17:30:10 INFO - Successfully installed blessings 17:30:10 INFO - Cleaning up... 17:30:10 INFO - Return code: 0 17:30:10 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:30:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:30:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:30:10 INFO - Reading from file tmpfile_stdout 17:30:10 INFO - Current package versions: 17:30:10 INFO - argparse == 1.2.1 17:30:10 INFO - blessings == 1.6 17:30:10 INFO - blobuploader == 1.2.4 17:30:10 INFO - docopt == 0.6.1 17:30:10 INFO - functools32 == 3.2.3-2 17:30:10 INFO - jsonschema == 2.5.1 17:30:10 INFO - manifestparser == 1.1 17:30:10 INFO - mozInstall == 1.13 17:30:10 INFO - mozcrash == 1.0 17:30:10 INFO - mozdebug == 0.1 17:30:10 INFO - mozdevice == 0.51 17:30:10 INFO - mozfile == 1.2 17:30:10 INFO - mozhttpd == 0.7 17:30:10 INFO - mozinfo == 0.10 17:30:10 INFO - mozleak == 0.1 17:30:10 INFO - mozlog == 3.5 17:30:10 INFO - moznetwork == 0.27 17:30:10 INFO - mozprocess == 0.25 17:30:10 INFO - mozprofile == 0.28 17:30:10 INFO - mozrunner == 6.13 17:30:10 INFO - mozscreenshot == 0.1 17:30:10 INFO - mozsystemmonitor == 0.3 17:30:10 INFO - moztest == 0.8 17:30:10 INFO - mozversion == 1.4 17:30:10 INFO - psutil == 3.1.1 17:30:10 INFO - requests == 1.2.3 17:30:10 INFO - wsgiref == 0.1.2 17:30:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:30:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:30:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:30:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:30:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:30:10 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 0x184e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a16b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bbb9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bb8d60>, '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 0x1bb9a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bb9ef0>, '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': '9bfb7e13875ed353a705960e000001c0-1506988797.877462-1087527954', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:30:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 17:30:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 17:30:10 INFO - Using env: {'DISPLAY': ':0', 17:30:10 INFO - 'HOME': '/home/cltbld', 17:30:10 INFO - 'LANG': 'en_US.UTF-8', 17:30:10 INFO - 'LANGUAGE': 'en_US:en', 17:30:10 INFO - 'LOGNAME': 'cltbld', 17:30:10 INFO - 'MAIL': '/var/mail/cltbld', 17:30:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:30:10 INFO - 'MOZ_NO_REMOTE': '1', 17:30:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:30:10 INFO - 'NO_EM_RESTART': '1', 17:30:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:30:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:30:10 INFO - 'PWD': '/builds/slave/test', 17:30:10 INFO - 'SHELL': '/bin/bash', 17:30:10 INFO - 'SHLVL': '1', 17:30:10 INFO - 'TERM': 'linux', 17:30:10 INFO - 'TMOUT': '86400', 17:30:10 INFO - 'USER': 'cltbld', 17:30:10 INFO - 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1506988797.877462-1087527954', 17:30:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:30:10 INFO - '_': '/tools/buildbot/bin/python'} 17:30:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:30:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 17:30:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 17:30:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 17:30:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 17:30:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 17:30:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 17:30:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 17:30:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 17:30:11 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 17:30:11 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 17:30:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:30:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:30:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:30:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:30:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 17:30:12 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 17:30:12 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 17:30:12 INFO - Installing collected packages: simplejson 17:30:12 INFO - Running setup.py install for simplejson 17:30:12 INFO - building 'simplejson._speedups' extension 17:30:12 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c simplejson/_speedups.c -o build/temp.linux-x86_64-2.7/simplejson/_speedups.o 17:30:13 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/simplejson/_speedups.o -o build/lib.linux-x86_64-2.7/simplejson/_speedups.so 17:30:13 INFO - Successfully installed simplejson 17:30:13 INFO - Cleaning up... 17:30:13 INFO - Return code: 0 17:30:13 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:30:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:30:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:30:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:30:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:30:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x184e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a16b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bbb9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bb8d60>, '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 0x1bb9a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bb9ef0>, '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': '9bfb7e13875ed353a705960e000001c0-1506988797.877462-1087527954', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:30:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 17:30:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 17:30:13 INFO - Using env: {'DISPLAY': ':0', 17:30:13 INFO - 'HOME': '/home/cltbld', 17:30:13 INFO - 'LANG': 'en_US.UTF-8', 17:30:13 INFO - 'LANGUAGE': 'en_US:en', 17:30:13 INFO - 'LOGNAME': 'cltbld', 17:30:13 INFO - 'MAIL': '/var/mail/cltbld', 17:30:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:30:13 INFO - 'MOZ_NO_REMOTE': '1', 17:30:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:30:13 INFO - 'NO_EM_RESTART': '1', 17:30:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:30:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:30:13 INFO - 'PWD': '/builds/slave/test', 17:30:13 INFO - 'SHELL': '/bin/bash', 17:30:13 INFO - 'SHLVL': '1', 17:30:13 INFO - 'TERM': 'linux', 17:30:13 INFO - 'TMOUT': '86400', 17:30:13 INFO - 'USER': 'cltbld', 17:30:13 INFO - 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1506988797.877462-1087527954', 17:30:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:30:13 INFO - '_': '/tools/buildbot/bin/python'} 17:30:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:30:13 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 17:30:13 INFO - Cleaning up... 17:30:13 INFO - Return code: 0 17:30:13 INFO - Running post-action listener: _resource_record_post_action 17:30:13 INFO - Running post-action listener: _start_resource_monitoring 17:30:13 INFO - Starting resource monitoring. 17:30:13 INFO - [mozharness: 2017-10-03 00:30:13.585733Z] Finished create-virtualenv step (success) 17:30:13 INFO - [mozharness: 2017-10-03 00:30:13.586251Z] Running install step. 17:30:13 INFO - Running pre-action listener: _resource_record_pre_action 17:30:13 INFO - Running main action method: install 17:30:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:30:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:30:13 INFO - Reading from file tmpfile_stdout 17:30:13 INFO - Detecting whether we're running mozinstall >=1.0... 17:30:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:30:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:30:13 INFO - Reading from file tmpfile_stdout 17:30:13 INFO - Output received: 17:30:13 INFO - Usage: mozinstall [options] installer 17:30:13 INFO - Options: 17:30:13 INFO - -h, --help show this help message and exit 17:30:13 INFO - -d DEST, --destination=DEST 17:30:13 INFO - Directory to install application into. [default: 17:30:13 INFO - "/builds/slave/test"] 17:30:13 INFO - --app=APP Application being installed. [default: firefox] 17:30:13 INFO - mkdir: /builds/slave/test/build/application 17:30:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 17:30:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 17:30:31 INFO - Reading from file tmpfile_stdout 17:30:31 INFO - Output received: 17:30:31 INFO - /builds/slave/test/build/application/firefox/firefox 17:30:31 INFO - Running post-action listener: _resource_record_post_action 17:30:31 INFO - [mozharness: 2017-10-03 00:30:31.722672Z] Finished install step (success) 17:30:31 INFO - [mozharness: 2017-10-03 00:30:31.722925Z] Running setup-mitmproxy step. 17:30:31 INFO - Running pre-action listener: _resource_record_pre_action 17:30:31 INFO - Running main action method: setup_mitmproxy 17:30:31 INFO - Skipping: mitmproxy is not required 17:30:31 INFO - Running post-action listener: _resource_record_post_action 17:30:31 INFO - [mozharness: 2017-10-03 00:30:31.724073Z] Finished setup-mitmproxy step (success) 17:30:31 INFO - [mozharness: 2017-10-03 00:30:31.724293Z] Running run-tests step. 17:30:31 INFO - Running pre-action listener: _resource_record_pre_action 17:30:31 INFO - Running pre-action listener: _set_gcov_prefix 17:30:31 INFO - Running main action method: run_tests 17:30:31 WARNING - Try message not found. 17:30:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:30:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:30:31 INFO - Python 2.7.3 17:30:31 INFO - Return code: 0 17:30:31 INFO - grabbing minidump binary from tooltool 17:30:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:30:31 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bb8d60>, '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 0x1bb9a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bb9ef0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:30:31 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 17:30:31 INFO - Copy/paste: /tools/tooltool.py --url https://tooltool.mozilla-releng.net/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 17:30:31 INFO - Calling ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 17:30:31 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:30:31 INFO - Return code: 0 17:30:31 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 17:30:31 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:30:31 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:30:31 INFO - ENV: RUST_BACKTRACE is now full 17:30:31 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 17:30:31 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:30:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-stylo-disabled-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Hy3hXRK2T5ipTB-nz_T5Yw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-076', '--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 17:30:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-stylo-disabled-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Hy3hXRK2T5ipTB-nz_T5Yw/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-076 --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 17:30:31 INFO - Using env: {'DISPLAY': ':0', 17:30:31 INFO - 'HOME': '/home/cltbld', 17:30:31 INFO - 'LANG': 'en_US.UTF-8', 17:30:31 INFO - 'LANGUAGE': 'en_US:en', 17:30:31 INFO - 'LOGNAME': 'cltbld', 17:30:31 INFO - 'MAIL': '/var/mail/cltbld', 17:30:31 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:30:31 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:30:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:30:31 INFO - 'MOZ_NO_REMOTE': '1', 17:30:31 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:30:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:30:31 INFO - 'NO_EM_RESTART': '1', 17:30:31 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:30:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:30:31 INFO - 'PWD': '/builds/slave/test', 17:30:31 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:30:31 INFO - 'RUST_BACKTRACE': 'full', 17:30:31 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 17:30:31 INFO - 'SHELL': '/bin/bash', 17:30:31 INFO - 'SHLVL': '1', 17:30:31 INFO - 'TERM': 'linux', 17:30:31 INFO - 'TMOUT': '86400', 17:30:31 INFO - 'USER': 'cltbld', 17:30:31 INFO - 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1506988797.877462-1087527954', 17:30:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:30:31 INFO - '_': '/tools/buildbot/bin/python'} 17:30:31 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-stylo-disabled-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Hy3hXRK2T5ipTB-nz_T5Yw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-076', '--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 17:30:32 INFO - mozversion application_buildid: 20171002232253 17:30:32 INFO - mozversion application_changeset: 65dac33a5682f3ec5a675e7f3314b0c1520a13fa 17:30:32 INFO - mozversion application_display_name: Nightly 17:30:32 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:30:32 INFO - mozversion application_name: Firefox 17:30:32 INFO - mozversion application_remotingname: firefox 17:30:32 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 17:30:32 INFO - mozversion application_vendor: Mozilla 17:30:32 INFO - mozversion application_version: 58.0a1 17:30:32 INFO - mozversion platform_buildid: 20171002232253 17:30:32 INFO - mozversion platform_changeset: 65dac33a5682f3ec5a675e7f3314b0c1520a13fa 17:30:32 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 17:30:32 INFO - mozversion platform_version: 58.0a1 17:30:32 INFO - using testdate: 1506990632 17:30:32 INFO - actual date: 1506990632 17:30:32 INFO - starting webserver on 'localhost:40037' 17:30:32 INFO - SUITE-START | Running 2 tests 17:30:32 INFO - TEST-START | dromaeo_css 17:30:32 INFO - Initialising browser for dromaeo_css test... 17:30:32 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:40037/getInfo.html -profile /tmp/tmpDeeBOH/profile 17:30:32 INFO - TEST-INFO | started process 970 (/builds/slave/test/build/application/firefox/firefox http://localhost:40037/getInfo.html) 17:30:37 INFO - TEST-INFO | 970: exit 0 17:30:38 INFO - Browser initialized. 17:30:38 INFO - Running cycle 1/1 for dromaeo_css test... 17:30:38 INFO - Using env: {'DISPLAY': ':0', 17:30:38 INFO - 'HOME': '/home/cltbld', 17:30:38 INFO - 'JSGC_DISABLE_POISONING': '1', 17:30:38 INFO - 'LANG': 'en_US.UTF-8', 17:30:38 INFO - 'LANGUAGE': 'en_US:en', 17:30:38 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 17:30:38 INFO - 'LOGNAME': 'cltbld', 17:30:38 INFO - 'MAIL': '/var/mail/cltbld', 17:30:38 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:30:38 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:30:38 INFO - 'MOZ_CRASHREPORTER': '1', 17:30:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:30:38 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 17:30:38 INFO - 'MOZ_NO_REMOTE': '1', 17:30:38 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:30:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:30:38 INFO - 'NO_EM_RESTART': '1', 17:30:38 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:30:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:30:38 INFO - 'PWD': '/builds/slave/test', 17:30:38 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:30:38 INFO - 'RUST_BACKTRACE': 'full', 17:30:38 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 17:30:38 INFO - 'SHELL': '/bin/bash', 17:30:38 INFO - 'SHLVL': '1', 17:30:38 INFO - 'STYLO_FORCE_DISABLED': '1', 17:30:38 INFO - 'TERM': 'linux', 17:30:38 INFO - 'TMOUT': '86400', 17:30:38 INFO - 'USER': 'cltbld', 17:30:38 INFO - 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1506988797.877462-1087527954', 17:30:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:30:38 INFO - '_': '/tools/buildbot/bin/python'} 17:30:38 INFO - TEST-INFO | started process 1253 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDeeBOH/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 17:30:39 INFO - PID 1253 | 17:30:39 INFO - PID 1253 | (/builds/slave/test/build/application/firefox/firefox:1371): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 17:30:39 INFO - PID 1253 | 17:30:49 INFO - PID 1253 | RSS: Main: 152596480 17:30:49 INFO - PID 1253 | 17:33:46 INFO - PID 1253 | Cycle 1(1): loaded http://localhost:40037/tests/dromaeo/cssquery-dojo.html (next: http://localhost:40037/tests/dromaeo/cssquery-ext.html) 17:33:48 INFO - PID 1253 | RSS: Main: 149729280 17:33:48 INFO - PID 1253 | 17:36:50 INFO - PID 1253 | Cycle 1(1): loaded http://localhost:40037/tests/dromaeo/cssquery-ext.html (next: http://localhost:40037/tests/dromaeo/cssquery-jquery.html) 17:36:50 INFO - PID 1253 | RSS: Main: 150900736 17:36:50 INFO - PID 1253 | 17:39:52 INFO - PID 1253 | Cycle 1(1): loaded http://localhost:40037/tests/dromaeo/cssquery-jquery.html (next: http://localhost:40037/tests/dromaeo/cssquery-mootools.html) 17:39:52 INFO - PID 1253 | RSS: Main: 152358912 17:39:52 INFO - PID 1253 | 17:42:54 INFO - PID 1253 | Cycle 1(1): loaded http://localhost:40037/tests/dromaeo/cssquery-mootools.html (next: http://localhost:40037/tests/dromaeo/cssquery-prototype.html) 17:42:55 INFO - PID 1253 | RSS: Main: 151937024 17:42:55 INFO - PID 1253 | 17:45:58 INFO - PID 1253 | Cycle 1(1): loaded http://localhost:40037/tests/dromaeo/cssquery-prototype.html (next: http://localhost:40037/tests/dromaeo/cssquery-yui.html) 17:45:59 INFO - PID 1253 | RSS: Main: 155308032 17:45:59 INFO - PID 1253 | 17:49:00 INFO - PID 1253 | Cycle 1(1): loaded http://localhost:40037/tests/dromaeo/cssquery-yui.html (next: http://localhost:40037/tests/dromaeo/cssquery-dojo.html) 17:49:00 INFO - PID 1253 | RSS: Main: 156069888 17:49:00 INFO - PID 1253 | 17:49:00 INFO - PID 1253 | __start_tp_report 17:49:00 INFO - PID 1253 | _x_x_mozilla_page_load 17:49:00 INFO - PID 1253 | _x_x_mozilla_page_load_details 17:49:00 INFO - PID 1253 | |i|pagename|runs| 17:49:00 INFO - PID 1253 | |0;dojo.html;3214.132184310236;3221.3235220603674;3241.108695108843;3244.059222825381;3270.0516850113468;6233.906491402633;6280.497560195185;6284;6371.139896114029;6413.422791948724;6289.402506761861;6335.113084168209;6345;6446.194225721785;6464.321246269133;5734.397888221739;5833.737481813318;5844;5909.6158749681135;5971.5222782177325;5687.516561092312;5793.565482588801;5870.26621672291;5893.086571581412;5910;5782.566307526931;5807.651540907538;5814.912776308359;5823.388544202882;5826.708664566755;5777.45114214149;5830.883382332329;5833.06670932653;5839.445252700986;5912.526997840206;5762.394948530427;5798.391168927286;5847.093700476433;5863;5881.794137205177;6227.657478838662;6319.74721011159;6336.46140078094;6413.486921046305;6464.159659244315;6834.931650683479;6873.20958089821;6876.587404755681;6881.621510816903;6900.482463815234;6851.1778586569435;6853.383195512428;6912.377885990285;6932.584044957268;6965.547239429421;6238.2825975013;6247.7188526515965;6300.527460440485;6328.303886572473;6334.049892516114;6952.026716259727;6952.409045231111;6956.930430695729;6959.338862808025;6971.058907047585;6501.122348482894;6531.216254049545;6616.569922954993;6624.701888415033;6667.6666166691475;6789.592624442549;6836.316368363124;6848.075509806113;6864.48516361265;6865.8328084225805;6771.492138089663;6772.187337519529;6823.829404264933;6853.93763966586;6866.073080134218;6670.566413183127;6771.052052712625;6792.694328755218;6816.216135144423;6913.75801846933;5364.9731751341;5369.704666243394;5371.75827087782;5377.596680248997;5384.165454354581;4706.670533062653;4713.552212539803;4754.809807607726;4773.546513081252;4783.067301876101;5856.502197313276;5869.882602347929;5878.2358293421585;5939.821805345847;5951.285845698458;6680.599164050075;6782.389584937379;6787.355201255873;6843.3840954314355;6939.271376505394;5765.019946609086;5769.307683077974;5777.277840269966;5803.100519419497;5866.911996320058;5681.829545113653;5767.077267637158;5767.394423585547;5777.104548794943;5782.045962416239;6458.838529036811;6528.934710652928;6583.703733332011;6606.240282367493;6611.272759996396;6690.698918548775;6750.797476075725;6790.354916282945;6803.659817009031;6816.0457535946;6480.805575832733;6533.575317604341;6545.738170473128;6561;6601.9009714853355;6592.241892182268;6723.596584204964;6728.158980127484;6728.764493242713;6755.054292399166;6771.085903403175;6788.355106265094;6803.625800581016;6852.314768523307;6860;6440.967795160994;6540.476761858945;6546.443552298108;6623.105880706235;6629.8729216032425;6565.244996825426;6567.2447668518735;6686.7993960181275;6690.531662783753;6693.598384096969;6485.513586481127;6486.740530378732;6574.76988305407;6587.341265873374;6601.669916504059;6609.074729537772;6618.271990080991;6627.204735431779;6691.46468282546;6721.395074443323;6250.687465626791;6258.624482531062;6338.58799178052;6348.714307856065;6441.420272175526 17:49:00 INFO - PID 1253 | |1;ext.html;859.4027151129965;873.0919843362902;878.9736307910761;880.3837313880285;884.3190743127793;38406.11954103439;39280;41789.37315940263;42105.368419473656;42149.36775948363;37706.0573485663;37847;37937.62062379375;37994.810025949904;38217;7118.822029449279;7245.6377181141;7247.565146091251;7249.927500724978;7279.781606551812;7186.245444228359;7226.349628533431;7248.021517095203;7279.3812525935355;7286.417086633083;7210;7233.746818861341;7271.309225623558;7750.806229844243;7995.200479952016;7879.212078792132;7959.761207163794;7978.720744773963;7982.720604778805;7996.280334769898;7785.844283114363;7843.568603726792;7885.566293853835;7911.564863932482;7915.643796029192;38988.61011389878;39719.20561588781;39768.20463590712;39819;39908.80045599782;3573.1960308930543;3598.9100272493397;3621.257642183346;3635.327464419091;3635.6909662678704;32782.83608581942;32950.340993180245;33012.17469563256;33015;33075.173120671934;5255.894882102375;5283.07546179417;5307.2569840222395;5319.308489896289;5334.493223143795;180572;181763;181971;182505;183030;41712.79143604262;42768;48231.75884120557;48394;48499;51726;52180.47819521832;52331;52404.21393679098;52530;15923.840761592235;16073.678526429407;16080.195990200444;16133.838661613469;16207.918960405359;13177;13238.801417978739;13248.602541923758;13255.933720331337;13268.203907765565;14084.647883802987;14108.224047677271;14191.64520886986;14206.218657973704;14296.356663950148;5871.647701137946;5883.676397798076;5927.1405646181065;5946.851328716817;5976.850578735566;1006.8389057750871;1020.0462567499412;1022.7238645565656;1025.661531694554;1031.0668844695563;22823.31530054068;22897.548366492498;23127.537449251256;23180;23400.18099366548;1109.9500522476508;1116.810142275815;1121.3103941076179;1130.960416385439;1131.5360702112096;11904.761904761855;12055.57805476804;12190.756184876253;12255.142140050111;12309.50761969529;227734;228342;229096;230486;230794;51115.233271500954;51402.48597513977;51678.22482662763;51762;51908.74045629748;1410.3864818803647;1450.0791997081717;1457.9489717859824;1474.1670955909876;1477.143256910989;22634.320970370914;22661.660075098556;22711.545769084856;22962.31113066611;22986.195483158008;31051.22371940629;31321;31612;31622.841885790425;31821.522677160323;192504;192777;193047;193473;193813;33909.830450847585;34455.483167752005;36134.457983129745;36306.27387452289;36420.27159456849;43689.78155109204;44957.55042449533;45103;45194.77402612966;45401.772991134836;33233.33533329368;33281.500777487876;33467.66532334645;33473.16317091995;33674.83162584171;33095.33809323848;33309.33381332408;33388.666113339525;33559.32881342409;33585.66414335923;37327;37450.250994979404;37492;37616.43575346427;37710;32205.838970804994;32236.83881580671;32373.67626323801;32506.187345316557;32676.34647307088;23749.05003799898;23990.28029159128;24204.87897560501;24253.878730606233;24308.635370469812 17:49:00 INFO - PID 1253 | |2;jquery.html;584.7456356484929;587.3861814403947;595.2321505258217;596.5227817745803;597.961132526386;21816.236431724894;21906.342809715694;22759.089636414545;22798.08807647692;22826.31521054371;25583.488330233384;26108.869455652744;26187.476250474978;26200.641942225197;26242.343941401476;6663.700133494004;6778.08495853061;6782.593044417326;6785.710714964166;6808.251092379859;6541.116949211867;6708.262091169968;7185.89221161683;7191.388731957763;7213.89179162313;7115.537490063155;7183.604901730403;7187.029750983603;7189.640517974107;7190.856182876366;7141;7142.21435642079;7180.784576462688;7183.353498185163;7194.928050719478;7015.789526314219;7017.0877785888015;7034;7040.577565346044;7044.401225895805;28730.856345718137;29716.257093572618;30561.847190764125;30751.538726919112;30803.229919251975;2121.5226574020876;2167.349795061491;2167.7398712154486;2173.6848157017303;2193.254293540188;19706.70439943402;20048.498787530283;20068.397948061436;20090.497737556532;20116.79883201164;2475.2450502596703;2509.473010667762;2577.6133579963157;2657.8139530232893;2665.8400495970304;143648;149061;149162.25418872945;149427;149483;19503.707444388347;20517.58964820695;21694.566108677736;21769.891150544147;22962.770372296396;22934.541309174056;24425;43431.56568434275;43480.78259608745;43910.78044609757;10058.295919285727;10086.899131008742;10157.593696252066;10169.644062457779;10382.117520010732;9120.315976301805;9201.159768046418;9246.26029917605;9304.90695093054;9346.345755797165;9299.488528131018;9380.296477764196;9511.952440237754;9580.0898914603;9619.450845525942;2602.375429896811;2628.5925681519393;2642.656454660882;2675.1305825606755;2693.7540263981855;963.6579014449769;986.4475893499663;987.5407935310116;989.2877128467492;1001.7595777013464;18989.430317090508;19073.2370705173;19245.903770481058;19711.60576788456;19863.801361986483;1056.4770438632927;1062.8033813744482;1069;1070.9196810239264;1075.8493810866485;10519.737006574896;10631.922735035794;10652.57389704403;10714.303570268063;11016.17378696601;451554;460651;469565;470059;472195;110456;114288.42855785668;114338;114814;114910.42544787223;1196.9102317326235;1201.0511695760426;1206.0713250797012;1209.4920133543933;1222.419350808359;16751.664966700842;17323.133843308035;17528.123593820514;17684.646307074043;17767.822321777134;54138.458615414915;56051;56063;57471;58514.70742646259;69469.65265173641;69809.65095174492;70163.29836701568;70833.29166708473;71078.28921710717;14443.927780361031;14594.489192878198;14659.193744344164;14679;14726.63183420423;22214.777852221272;22255;22334.329970100924;22569.548609028057;22700.432489187904;17801.1989460472;17904.91047544754;18010.90994545019;18110.72833907466;18211.180496877936;13992.720145597235;14198.148111113367;14273;15089.773653394988;15362.30869610848;18505.629887402447;18628.534286642942;18672.346467873558;18806.811931881053;18899.433017009513;13803.654908627364;14365.7845132321;14574.417023318949;14585.489507867174;14617.853821462075;17562.12189390551;17595;17935.73096403529;18001;18019.639607208046 17:49:00 INFO - PID 1253 | |3;mootools.html;1283.8266833977411;1345.5559665310448;1346.0683918576838;1346.710457251691;1348.7167694784089;14607.926960365197;15031.398744050224;15037.924810375947;15078.547643570682;15086.019408738439;14609.634759131028;14778.482753103617;14787.704245915074;14788.778168327484;14828.258587070657;2790.4000639862425;2799.7340252675963;2835.688074311824;2836.3618185908213;2842.3036356092784;2673.17131689177;2765.308672831792;2774.8057635965492;2781.3741908070624;2785.7214278572183;2611.3602167468903;2735.4529094181144;2841.6447944007;2855.457463082018;2859.2851787053237;2799.3281612412875;2827.0953294945625;2851.2159156231996;2857.6142220800134;2859;2796.734310240524;2800.369916768731;2817.7182281771866;2836.248394175545;2840.5171120909495;14916.179610121439;15162;15166.31751571171;15184.468543601031;15211;7948.244916732901;8140.3487720982175;8240;8262.297704695107;8262.545559994198;5097.2608971699265;5169.198774190007;5211.478852114758;5287.762050707689;5440.6735595864375;1878.4928069421317;1885.5945971616168;1889.1782074797507;1928.623918335925;1934.3616606519815;26795;26968.325791855164;27197.184084477496;27238.04666836651;27252.59121113185;6522.478201743849;6618.205815302194;6624.768133115318;6799.4900382471515;6850.0752398425575;17811.46565603008;17871.553211169823;17879.642407152045;17890.91054544745;17894.91052544729;7915.089764677021;8243.2581067703;8245.546494942715;8260.504369737835;8275.420720549624;7221.963890180516;7327.633618319062;7343.816404589928;7409.592472413961;7413.2957369049855;5083.364579427572;5262.079136151235;5262.236975638511;5281;5297.470252974749;1323.4176962136628;1340.5911197084788;1409.8378686450985;1436.080908218741;1456.8615981481742;775.0892701076212;810.4974915552277;812.4110020235282;816.8856360109589;819.8073452738602;7429.33136017761;7628.46600737943;7653.272939070779;7681.155072941972;7690.73082442123;715.8389362393524;728.3663213004614;736.4219088015882;803.2569872867574;827.2678679368681;4507.166174257773;4541.500434952152;4625.468071171791;4767.094252092161;4862.489438608965;20892.686609700868;21213.939303034786;21304.467388315104;21342.253021144184;21535.353939381843;20989.68515472269;21251.46871328198;22113.55772884533;22333.441663958205;22743.431414214778;10799.920007999137;11206.887931120747;11248.550057997589;11264.267822591506;11416.486258118404;7141.250168732208;7278.417726581966;7342.265773422615;7398.593077380796;7443.44174186949;18223;18800.905995469937;18874.811251887306;19341.4197574073;19497.512562186057;19256.807431925503;19425.222991080198;19511.804881951;19656.21375144978;19677.606447870676;11103.444827758742;11278.210525263154;11362.886371136183;11378.658640240807;11382.54469821198;13943.233122178377;14029.3686784097;14106.435742570182;14120;14127.858721413066;11359.943200283946;11527.827082593936;11578;11688.88311116878;11833.349165795964;11239.719007024889;11279.7744045117;11355.659330220107;11384.43077846121;11559.942200288944;9487.09872562133;9521.047895210424;9606.66376676841;9616.990216027496;9628.66299679508;6845.386782838025;6913.10129683138;7029.507934444744;7057.6471176439945;7073.2219455858785;7013.2986701329455;7029.156501219886;7043.823904402226;7075.929240707733;7118.857622847618 17:49:00 INFO - PID 1253 | |4;prototype.html;506.5188071332233;519.2444992535859;539.7193459401111;542.3139728243775;546.6719968019188;6199.907001394983;6269.7492100315985;6269.780557680482;6291.33940936202;6372.745090196387;6132.693365331738;6160.815175544741;6216.191895053648;6226.688665566726;6237.906431403521;5180.870478238036;5190.844274671766;5205.947940520584;5220.504052115043;5230.816921407752;4864.805407783702;5002.349694539705;5173.741312934357;5177.844664660048;5206.869828254286;4943.060818444502;4979.8008079676765;4983.900321993558;4988.052270068675;4988.451270360258;4965.478624744404;4986.82546110888;4987.950120498785;4999.400071991385;5020.447750747415;4376.518582955872;4462.330650402433;4466;4484.618807401374;4490;6049.758009679607;6061.636301821904;6098.176746139259;6113.44978951892;6126.509879209652;5684.715764211773;5699.2590963174935;5720.22776925114;5721.4850663440075;5730.312362516524;6528.11870397495;6544.803655890331;6552.180977377828;6563.803085907431;6579.769708060243;4699.976500117477;4913.164761990471;4914.164592019365;4920.8769780755765;4936.160852655057;6566.8358291043105;6587.637679927602;6814.318568143196;6846.589204647687;6848.178218613699;4990.600751939836;5018.222175562721;5028.245763135559;5030.673006254582;5037.546620804145;5059.988002399535;5064.848054558369;5084.618653600995;5090.720010399389;5105.923411148836;5667.829965101054;5687.146927960839;5695.430456954355;5716.628419152825;5744.253247077853;6511.544191906521;6591.703373348115;6594.505412094112;6604.669766511655;6613.933860661428;1748.728947013215;1761.6917039518032;1767.1782621081259;1778.457570441002;1791.2924394864217;1167.1363191238422;1223.1376879300071;1230;1237.6287113865803;1262.6174339098673;5610.607257492018;5627.199296225169;5645.604807663424;5653.858653533694;5654.476418864974;6336.936630633634;6543.640099794462;6552.279249282575;6669.966650166718;6674.666266686646;5582.944170558324;5593.244911936918;5594.776208951596;5617.9719101404235;5643.35101463337;3459.9481007784902;3472.913177170591;3506.298740251909;3530.805805680712;3563.4120370138635;6381.744730210739;6452.483801295885;6507.967460162668;6510.348965103546;6523.804285871432;6753.662316884136;6817.488688348394;6819.465620235407;6876.965615171992;6911.203087197265;6459.935400645933;6461.709223084972;6467.611943283418;6501.609903405716;6506.527519542638;6651.50113741481;6702.899456508254;6708.899366509604;6752.527323087336;6806.319368063154;6687.264400915798;6687.264400915993;6706.195256569243;6721.899171512334;6725.932740672726;6459;6478.2550006749825;6517.902231466437;6532.967335163294;6556.442702370352;5042.092423363683;5044.695724300443;5065.366829146356;5068.695878247317;5078.949210507848;6388.96805515988;6556;6621.205455345389;6779.389854913082;6791.830204244933;6130.938690613215;6379.457746091634;6430.967845160932;6444.4844412445955;6491.870162596816;6371.39471750183;6422.3577642235405;6472.320406357265;6473.158489396348;6496.480281577557;6182.258129024546;6299;6324.110671936818;6366.554341196072;6436.517261205522;6413.16628838248;6470.22357317125;6475.967620161869;6505.447037001908;6555.147830781968;6201.441870231701;6257.53068519872;6273.278572964167;6325.557210995186;6337.493000560036 17:49:00 INFO - PID 1253 | |5;yui.html;906.0622255965078;918.6646873891029;943.1841457139576;943.6508491858009;955.3408148377619;19660.311889083885;20370.59258814823;20424.489387765312;20470.2835400761;20487.18051277949;19088.71366929497;19211.807881921177;19554.31559895404;19594.412167634957;19920.800791992075;957.1385752822463;969.1713584884927;971.7036303927299;971.7764914069768;974.3374505336368;955.1785464500524;1000.8548760429734;1003.14231332211;1003.5784970312486;1003.6136087606251;1051.3324039235065;1062.941538215398;1063.2132222155587;1063.9893601064007;1064.0476773287942;1056.7252514346249;1058.227493929436;1059.5285098131296;1059.7986382587283;1060.178361769627;732.454321530458;738.9408847292258;752.8494301139739;754.1591125894643;769.8229407236311;20301;20315.984200789902;20436;20439.591208175752;20513.794862051338;21406.357809265748;21509.354719358445;22369.440763980867;22549.436264093365;22555.774442255697;13679.658008549866;13830.792538111937;13858.16850988944;13944.16335019902;14046.297685115806;3798.1833905710405;3812.1041555234497;3812.1803812180237;3815.084379748868;3823.541175058983;125542;127825;128043.35978320049;129487;129698;16936;17057.147142642818;17244.482665520056;17270.13649317529;17395.304187832597;31110.22224444407;31199.22001949924;31670.36659266802;31874;31904.840475797937;8861.64553417869;9060.728178154666;9063.954680226689;9064.954675226714;9067.04795996411;4112.773797441169;4131.462909821704;4159.272127377697;4161.708680392404;4164.604362585549;4875.049365373789;4920.065187614342;4943;4965.031818795373;5003.2745251938995;984.4093543873619;991.0733464210986;995.8506224066304;1000.7298029531986;1003.7841863999275;671.1711036869463;677.3260605697265;694.982625434358;697.7034760226883;702.4380495603497;11680.357580332993;11895.70260743471;12076.154669173073;12963;13247.271400072896;674.1337381464795;681.877262092828;684.7021545627667;694.3438450664175;697.6965020216222;5262.10544207478;5273.78904843802;5278.736063196901;5281.781651706293;5314.70769107695;118330;118486;118710;119958;123914.38042809728;106848.93151068545;109196;109682.45158774155;110276;114963;93802.53098734462;95177.52411237899;95764.52117739366;96955;97418;9942.900570994198;9948.502574871083;9962.352447090916;9980.900190997998;10119.392836429837;44972.325415118146;45255.32117018313;45667.54332456766;46933.76533117313;47677;56047;57639.711801440724;57886;58003;59906;14661.266936653337;14950.25248737537;14953.177575233032;15061.246937652855;15080.773788393402;17272.395466159127;17725;17755.644887102444;17766.911165444606;17767.20047597887;14691.55925322242;14729.337179827147;14764;14827.92586037063;14859.034162779384;15629.609259768597;15796.76304855451;15908.761368579711;16053.277602507682;16109.275082621076;15119.622009449851;15230.23848807533;15245.16151611672;15469.922650386676;15501.84498155004;12081.516739330329;12153.1492795507;12475.625731228078;12487.12590118683;12534.373281335715;12745.808812867628;12817.87182128204;12834.97320214362;12896.677583060498;13175.07774455779 17:49:00 INFO - PID 1253 | __end_tp_report 17:49:00 INFO - PID 1253 | __start_cc_report 17:49:00 INFO - PID 1253 | _x_x_mozilla_cycle_collect,282 17:49:00 INFO - PID 1253 | __end_cc_report 17:49:00 INFO - PID 1253 | __startTimestamp1506991740921__endTimestamp 17:49:00 INFO - PID 1253 | 17:49:00 INFO - PID 1253 | ------- Summary: start ------- 17:49:00 INFO - PID 1253 | Number of tests: 6 17:49:00 INFO - PID 1253 | 17:49:00 INFO - PID 1253 | [#0] dojo.html Cycles:165 Average:6242.80 Median:6480.81 stddev:737.75 (11.4%) stddev-sans-first:700.71 17:49:00 INFO - PID 1253 | Values: 3214.1 3221.3 3241.1 3244.1 3270.1 6233.9 6280.5 6284.0 6371.1 6413.4 6289.4 6335.1 6345.0 6446.2 6464.3 5734.4 5833.7 5844.0 5909.6 5971.5 5687.5 5793.6 5870.3 5893.1 5910.0 5782.6 5807.7 5814.9 5823.4 5826.7 5777.5 5830.9 5833.1 5839.4 5912.5 5762.4 5798.4 5847.1 5863.0 5881.8 6227.7 6319.7 6336.5 6413.5 6464.2 6834.9 6873.2 6876.6 6881.6 6900.5 6851.2 6853.4 6912.4 6932.6 6965.5 6238.3 6247.7 6300.5 6328.3 6334.0 6952.0 6952.4 6956.9 6959.3 6971.1 6501.1 6531.2 6616.6 6624.7 6667.7 6789.6 6836.3 6848.1 6864.5 6865.8 6771.5 6772.2 6823.8 6853.9 6866.1 6670.6 6771.1 6792.7 6816.2 6913.8 5365.0 5369.7 5371.8 5377.6 5384.2 4706.7 4713.6 4754.8 4773.5 4783.1 5856.5 5869.9 5878.2 5939.8 5951.3 6680.6 6782.4 6787.4 6843.4 6939.3 5765.0 5769.3 5777.3 5803.1 5866.9 5681.8 5767.1 5767.4 5777.1 5782.0 6458.8 6528.9 6583.7 6606.2 6611.3 6690.7 6750.8 6790.4 6803.7 6816.0 6480.8 6533.6 6545.7 6561.0 6601.9 6592.2 6723.6 6728.2 6728.8 6755.1 6771.1 6788.4 6803.6 6852.3 6860.0 6441.0 6540.5 6546.4 6623.1 6629.9 6565.2 6567.2 6686.8 6690.5 6693.6 6485.5 6486.7 6574.8 6587.3 6601.7 6609.1 6618.3 6627.2 6691.5 6721.4 6250.7 6258.6 6338.6 6348.7 6441.4 17:49:00 INFO - PID 1253 | 17:49:00 INFO - PID 1253 | [#1] ext.html Cycles:180 Average:37129.40 Median:34182.66 stddev:52416.02 (153.3%) stddev-sans-first:52492.31 17:49:00 INFO - PID 1253 | Values: 859.4 873.1 879.0 880.4 884.3 38406.1 39280.0 41789.4 42105.4 42149.4 37706.1 37847.0 37937.6 37994.8 38217.0 7118.8 7245.6 7247.6 7249.9 7279.8 7186.2 7226.3 7248.0 7279.4 7286.4 7210.0 7233.7 7271.3 7750.8 7995.2 7879.2 7959.8 7978.7 7982.7 7996.3 7785.8 7843.6 7885.6 7911.6 7915.6 38988.6 39719.2 39768.2 39819.0 39908.8 3573.2 3598.9 3621.3 3635.3 3635.7 32782.8 32950.3 33012.2 33015.0 33075.2 5255.9 5283.1 5307.3 5319.3 5334.5 180572.0 181763.0 181971.0 182505.0 183030.0 41712.8 42768.0 48231.8 48394.0 48499.0 51726.0 52180.5 52331.0 52404.2 52530.0 15923.8 16073.7 16080.2 16133.8 16207.9 13177.0 13238.8 13248.6 13255.9 13268.2 14084.6 14108.2 14191.6 14206.2 14296.4 5871.6 5883.7 5927.1 5946.9 5976.9 1006.8 1020.0 1022.7 1025.7 1031.1 22823.3 22897.5 23127.5 23180.0 23400.2 1110.0 1116.8 1121.3 1131.0 1131.5 11904.8 12055.6 12190.8 12255.1 12309.5 227734.0 228342.0 229096.0 230486.0 230794.0 51115.2 51402.5 51678.2 51762.0 51908.7 1410.4 1450.1 1457.9 1474.2 1477.1 22634.3 22661.7 22711.5 22962.3 22986.2 31051.2 31321.0 31612.0 31622.8 31821.5 192504.0 192777.0 193047.0 193473.0 193813.0 33909.8 34455.5 36134.5 36306.3 36420.3 43689.8 44957.6 45103.0 45194.8 45401.8 33233.3 33281.5 33467.7 33473.2 33674.8 33095.3 33309.3 33388.7 33559.3 33585.7 37327.0 37450.3 37492.0 37616.4 37710.0 32205.8 32236.8 32373.7 32506.2 32676.3 23749.1 23990.3 24204.9 24253.9 24308.6 17:49:00 INFO - PID 1253 | 17:49:00 INFO - PID 1253 | [#2] jquery.html Cycles:180 Average:34784.65 Median:22634.99 stddev:78986.30 (349.0%) stddev-sans-first:79166.14 17:49:00 INFO - PID 1253 | Values: 584.7 587.4 595.2 596.5 598.0 21816.2 21906.3 22759.1 22798.1 22826.3 25583.5 26108.9 26187.5 26200.6 26242.3 6663.7 6778.1 6782.6 6785.7 6808.3 6541.1 6708.3 7185.9 7191.4 7213.9 7115.5 7183.6 7187.0 7189.6 7190.9 7141.0 7142.2 7180.8 7183.4 7194.9 7015.8 7017.1 7034.0 7040.6 7044.4 28730.9 29716.3 30561.8 30751.5 30803.2 2121.5 2167.3 2167.7 2173.7 2193.3 19706.7 20048.5 20068.4 20090.5 20116.8 2475.2 2509.5 2577.6 2657.8 2665.8 143648.0 149061.0 149162.3 149427.0 149483.0 19503.7 20517.6 21694.6 21769.9 22962.8 22934.5 24425.0 43431.6 43480.8 43910.8 10058.3 10086.9 10157.6 10169.6 10382.1 9120.3 9201.2 9246.3 9304.9 9346.3 9299.5 9380.3 9512.0 9580.1 9619.5 2602.4 2628.6 2642.7 2675.1 2693.8 963.7 986.4 987.5 989.3 1001.8 18989.4 19073.2 19245.9 19711.6 19863.8 1056.5 1062.8 1069.0 1070.9 1075.8 10519.7 10631.9 10652.6 10714.3 11016.2 451554.0 460651.0 469565.0 470059.0 472195.0 110456.0 114288.4 114338.0 114814.0 114910.4 1196.9 1201.1 1206.1 1209.5 1222.4 16751.7 17323.1 17528.1 17684.6 17767.8 54138.5 56051.0 56063.0 57471.0 58514.7 69469.7 69809.7 70163.3 70833.3 71078.3 14443.9 14594.5 14659.2 14679.0 14726.6 22214.8 22255.0 22334.3 22569.5 22700.4 17801.2 17904.9 18010.9 18110.7 18211.2 13992.7 14198.1 14273.0 15089.8 15362.3 18505.6 18628.5 18672.3 18806.8 18899.4 13803.7 14365.8 14574.4 14585.5 14617.9 17562.1 17595.0 17935.7 18001.0 18019.6 17:49:00 INFO - PID 1253 | 17:49:00 INFO - PID 1253 | [#3] mootools.html Cycles:180 Average:9311.54 Median:2783.55 stddev:6782.70 (243.7%) stddev-sans-first:6774.91 17:49:00 INFO - PID 1253 | Values: 1283.8 1345.6 1346.1 1346.7 1348.7 14607.9 15031.4 15037.9 15078.5 15086.0 14609.6 14778.5 14787.7 14788.8 14828.3 2790.4 2799.7 2835.7 2836.4 2842.3 2673.2 2765.3 2774.8 2781.4 2785.7 2611.4 2735.5 2841.6 2855.5 2859.3 2799.3 2827.1 2851.2 2857.6 2859.0 2796.7 2800.4 2817.7 2836.2 2840.5 14916.2 15162.0 15166.3 15184.5 15211.0 7948.2 8140.3 8240.0 8262.3 8262.5 5097.3 5169.2 5211.5 5287.8 5440.7 1878.5 1885.6 1889.2 1928.6 1934.4 26795.0 26968.3 27197.2 27238.0 27252.6 6522.5 6618.2 6624.8 6799.5 6850.1 17811.5 17871.6 17879.6 17890.9 17894.9 7915.1 8243.3 8245.5 8260.5 8275.4 7222.0 7327.6 7343.8 7409.6 7413.3 5083.4 5262.1 5262.2 5281.0 5297.5 1323.4 1340.6 1409.8 1436.1 1456.9 775.1 810.5 812.4 816.9 819.8 7429.3 7628.5 7653.3 7681.2 7690.7 715.8 728.4 736.4 803.3 827.3 4507.2 4541.5 4625.5 4767.1 4862.5 20892.7 21213.9 21304.5 21342.3 21535.4 20989.7 21251.5 22113.6 22333.4 22743.4 10799.9 11206.9 11248.6 11264.3 11416.5 7141.3 7278.4 7342.3 7398.6 7443.4 18223.0 18800.9 18874.8 19341.4 19497.5 19256.8 19425.2 19511.8 19656.2 19677.6 11103.4 11278.2 11362.9 11378.7 11382.5 13943.2 14029.4 14106.4 14120.0 14127.9 11359.9 11527.8 11578.0 11688.9 11833.3 11239.7 11279.8 11355.7 11384.4 11559.9 9487.1 9521.0 9606.7 9617.0 9628.7 6845.4 6913.1 7029.5 7057.6 7073.2 7013.3 7029.2 7043.8 7075.9 7118.9 17:49:00 INFO - PID 1253 | 17:49:00 INFO - PID 1253 | [#4] prototype.html Cycles:180 Average:5491.64 Median:6131.82 stddev:1524.38 (24.9%) stddev-sans-first:1482.02 17:49:00 INFO - PID 1253 | Values: 506.5 519.2 539.7 542.3 546.7 6199.9 6269.7 6269.8 6291.3 6372.7 6132.7 6160.8 6216.2 6226.7 6237.9 5180.9 5190.8 5205.9 5220.5 5230.8 4864.8 5002.3 5173.7 5177.8 5206.9 4943.1 4979.8 4983.9 4988.1 4988.5 4965.5 4986.8 4988.0 4999.4 5020.4 4376.5 4462.3 4466.0 4484.6 4490.0 6049.8 6061.6 6098.2 6113.4 6126.5 5684.7 5699.3 5720.2 5721.5 5730.3 6528.1 6544.8 6552.2 6563.8 6579.8 4700.0 4913.2 4914.2 4920.9 4936.2 6566.8 6587.6 6814.3 6846.6 6848.2 4990.6 5018.2 5028.2 5030.7 5037.5 5060.0 5064.8 5084.6 5090.7 5105.9 5667.8 5687.1 5695.4 5716.6 5744.3 6511.5 6591.7 6594.5 6604.7 6613.9 1748.7 1761.7 1767.2 1778.5 1791.3 1167.1 1223.1 1230.0 1237.6 1262.6 5610.6 5627.2 5645.6 5653.9 5654.5 6336.9 6543.6 6552.3 6670.0 6674.7 5582.9 5593.2 5594.8 5618.0 5643.4 3459.9 3472.9 3506.3 3530.8 3563.4 6381.7 6452.5 6508.0 6510.3 6523.8 6753.7 6817.5 6819.5 6877.0 6911.2 6459.9 6461.7 6467.6 6501.6 6506.5 6651.5 6702.9 6708.9 6752.5 6806.3 6687.3 6687.3 6706.2 6721.9 6725.9 6459.0 6478.3 6517.9 6533.0 6556.4 5042.1 5044.7 5065.4 5068.7 5078.9 6389.0 6556.0 6621.2 6779.4 6791.8 6130.9 6379.5 6431.0 6444.5 6491.9 6371.4 6422.4 6472.3 6473.2 6496.5 6182.3 6299.0 6324.1 6366.6 6436.5 6413.2 6470.2 6476.0 6505.4 6555.1 6201.4 6257.5 6273.3 6325.6 6337.5 17:49:00 INFO - PID 1253 | 17:49:00 INFO - PID 1253 | [#5] yui.html Cycles:180 Average:24010.66 Median:20397.54 stddev:34257.84 (168.0%) stddev-sans-first:34310.02 17:49:00 INFO - PID 1253 | Values: 906.1 918.7 943.2 943.7 955.3 19660.3 20370.6 20424.5 20470.3 20487.2 19088.7 19211.8 19554.3 19594.4 19920.8 957.1 969.2 971.7 971.8 974.3 955.2 1000.9 1003.1 1003.6 1003.6 1051.3 1062.9 1063.2 1064.0 1064.0 1056.7 1058.2 1059.5 1059.8 1060.2 732.5 738.9 752.8 754.2 769.8 20301.0 20316.0 20436.0 20439.6 20513.8 21406.4 21509.4 22369.4 22549.4 22555.8 13679.7 13830.8 13858.2 13944.2 14046.3 3798.2 3812.1 3812.2 3815.1 3823.5 125542.0 127825.0 128043.4 129487.0 129698.0 16936.0 17057.1 17244.5 17270.1 17395.3 31110.2 31199.2 31670.4 31874.0 31904.8 8861.6 9060.7 9064.0 9065.0 9067.0 4112.8 4131.5 4159.3 4161.7 4164.6 4875.0 4920.1 4943.0 4965.0 5003.3 984.4 991.1 995.9 1000.7 1003.8 671.2 677.3 695.0 697.7 702.4 11680.4 11895.7 12076.2 12963.0 13247.3 674.1 681.9 684.7 694.3 697.7 5262.1 5273.8 5278.7 5281.8 5314.7 118330.0 118486.0 118710.0 119958.0 123914.4 106848.9 109196.0 109682.5 110276.0 114963.0 93802.5 95177.5 95764.5 96955.0 97418.0 9942.9 9948.5 9962.4 9980.9 10119.4 44972.3 45255.3 45667.5 46933.8 47677.0 56047.0 57639.7 57886.0 58003.0 59906.0 14661.3 14950.3 14953.2 15061.2 15080.8 17272.4 17725.0 17755.6 17766.9 17767.2 14691.6 14729.3 14764.0 14827.9 14859.0 15629.6 15796.8 15908.8 16053.3 16109.3 15119.6 15230.2 15245.2 15469.9 15501.8 12081.5 12153.1 12475.6 12487.1 12534.4 12745.8 12817.9 12835.0 12896.7 13175.1 17:49:00 INFO - PID 1253 | -------- Summary: end -------- 17:49:00 INFO - PID 1253 | 17:49:01 INFO - TEST-INFO | 1253: exit 0 17:49:01 INFO - TEST-OK | dromaeo_css | took 1109360ms 17:49:01 INFO - TEST-START | kraken 17:49:01 INFO - Initialising browser for kraken test... 17:49:01 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:40037/getInfo.html -profile /tmp/tmpVi7vXI/profile 17:49:01 INFO - TEST-INFO | started process 1716 (/builds/slave/test/build/application/firefox/firefox http://localhost:40037/getInfo.html) 17:49:06 INFO - TEST-INFO | 1716: exit 0 17:49:06 INFO - Browser initialized. 17:49:06 INFO - Running cycle 1/1 for kraken test... 17:49:06 INFO - Using env: {'DISPLAY': ':0', 17:49:06 INFO - 'HOME': '/home/cltbld', 17:49:06 INFO - 'JSGC_DISABLE_POISONING': '1', 17:49:06 INFO - 'LANG': 'en_US.UTF-8', 17:49:06 INFO - 'LANGUAGE': 'en_US:en', 17:49:06 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 17:49:06 INFO - 'LOGNAME': 'cltbld', 17:49:06 INFO - 'MAIL': '/var/mail/cltbld', 17:49:06 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:49:06 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:49:06 INFO - 'MOZ_CRASHREPORTER': '1', 17:49:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:49:06 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 17:49:06 INFO - 'MOZ_NO_REMOTE': '1', 17:49:06 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:49:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:49:06 INFO - 'NO_EM_RESTART': '1', 17:49:06 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:49:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:49:06 INFO - 'PWD': '/builds/slave/test', 17:49:06 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:49:06 INFO - 'RUST_BACKTRACE': 'full', 17:49:06 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 17:49:06 INFO - 'SHELL': '/bin/bash', 17:49:06 INFO - 'SHLVL': '1', 17:49:06 INFO - 'STYLO_FORCE_DISABLED': '1', 17:49:06 INFO - 'TERM': 'linux', 17:49:06 INFO - 'TMOUT': '86400', 17:49:06 INFO - 'USER': 'cltbld', 17:49:06 INFO - 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1506988797.877462-1087527954', 17:49:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:49:06 INFO - '_': '/tools/buildbot/bin/python'} 17:49:06 INFO - TEST-INFO | started process 1985 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpVi7vXI/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 17:49:07 INFO - PID 1985 | 17:49:07 INFO - PID 1985 | (/builds/slave/test/build/application/firefox/firefox:2033): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 17:49:07 INFO - PID 1985 | 17:49:17 INFO - PID 1985 | RSS: Main: 154710016 17:49:17 INFO - PID 1985 | 17:49:20 INFO - PID 1985 | Cycle 1(1): loaded http://localhost:40037/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:40037/tests/kraken/driver.html?testName=audio-beat-detection) 17:49:21 INFO - PID 1985 | RSS: Main: 160387072 17:49:21 INFO - PID 1985 | 17:49:24 INFO - PID 1985 | Cycle 1(1): loaded http://localhost:40037/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:40037/tests/kraken/driver.html?testName=audio-dft) 17:49:24 INFO - PID 1985 | RSS: Main: 160456704 17:49:24 INFO - PID 1985 | 17:49:27 INFO - PID 1985 | Cycle 1(1): loaded http://localhost:40037/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:40037/tests/kraken/driver.html?testName=audio-fft) 17:49:28 INFO - PID 1985 | RSS: Main: 156938240 17:49:28 INFO - PID 1985 | 17:49:30 INFO - PID 1985 | Cycle 1(1): loaded http://localhost:40037/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:40037/tests/kraken/driver.html?testName=audio-oscillator) 17:49:31 INFO - PID 1985 | RSS: Main: 157487104 17:49:31 INFO - PID 1985 | 17:49:33 INFO - PID 1985 | Cycle 1(1): loaded http://localhost:40037/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:40037/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:49:33 INFO - PID 1985 | RSS: Main: 157753344 17:49:33 INFO - PID 1985 | 17:49:36 INFO - PID 1985 | Cycle 1(1): loaded http://localhost:40037/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:40037/tests/kraken/driver.html?testName=imaging-darkroom) 17:49:37 INFO - PID 1985 | RSS: Main: 159776768 17:49:37 INFO - PID 1985 | 17:49:41 INFO - PID 1985 | Cycle 1(1): loaded http://localhost:40037/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:40037/tests/kraken/driver.html?testName=imaging-desaturate) 17:49:41 INFO - PID 1985 | RSS: Main: 159789056 17:49:41 INFO - PID 1985 | 17:49:44 INFO - PID 1985 | Cycle 1(1): loaded http://localhost:40037/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:40037/tests/kraken/driver.html?testName=json-parse-financial) 17:49:45 INFO - PID 1985 | RSS: Main: 160088064 17:49:45 INFO - PID 1985 | 17:49:47 INFO - PID 1985 | Cycle 1(1): loaded http://localhost:40037/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:40037/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:49:47 INFO - PID 1985 | RSS: Main: 159924224 17:49:47 INFO - PID 1985 | 17:49:49 INFO - PID 1985 | Cycle 1(1): loaded http://localhost:40037/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:40037/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:49:49 INFO - PID 1985 | RSS: Main: 160272384 17:49:49 INFO - PID 1985 | 17:49:51 INFO - PID 1985 | Cycle 1(1): loaded http://localhost:40037/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:40037/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:49:52 INFO - PID 1985 | RSS: Main: 156893184 17:49:52 INFO - PID 1985 | 17:49:55 INFO - PID 1985 | Cycle 1(1): loaded http://localhost:40037/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:40037/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:49:55 INFO - PID 1985 | RSS: Main: 156901376 17:49:55 INFO - PID 1985 | 17:49:58 INFO - PID 1985 | Cycle 1(1): loaded http://localhost:40037/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:40037/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:49:59 INFO - PID 1985 | RSS: Main: 157249536 17:49:59 INFO - PID 1985 | 17:50:00 INFO - PID 1985 | Cycle 1(1): loaded http://localhost:40037/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:40037/tests/kraken/driver.html?testName=ai-astar) 17:50:01 INFO - PID 1985 | RSS: Main: 158507008 17:50:01 INFO - PID 1985 | 17:50:01 INFO - PID 1985 | __start_tp_report 17:50:01 INFO - PID 1985 | _x_x_mozilla_page_load 17:50:01 INFO - PID 1985 | _x_x_mozilla_page_load_details 17:50:01 INFO - PID 1985 | |i|pagename|runs| 17:50:01 INFO - PID 1985 | |0;ai-astar;107;106;105;107;105;110;106;108;108;107 17:50:01 INFO - PID 1985 | |1;audio-beat-detection;116;115;117;118;115;117;115;120;116;116 17:50:01 INFO - PID 1985 | |2;audio-dft;163;163;164;162;162;164;163;162;163;169 17:50:01 INFO - PID 1985 | |3;audio-fft;76;75;75;79;75;74;72;73;74;74 17:50:01 INFO - PID 1985 | |4;audio-oscillator;79;79;79;78;78;79;79;78;78;79 17:50:01 INFO - PID 1985 | |5;imaging-gaussian-blur;114;114;114;113;110;114;114;114;111;113 17:50:01 INFO - PID 1985 | |6;imaging-darkroom;159;148;147;149;148;148;149;148;148;147 17:50:01 INFO - PID 1985 | |7;imaging-desaturate;94;94;93;93;94;95;94;94;94;97 17:50:01 INFO - PID 1985 | |8;json-parse-financial;55;53;52;53;53;53;53;52;54;56 17:50:01 INFO - PID 1985 | |9;json-stringify-tinderbox;38;38;37;38;37;37;37;37;39;40 17:50:01 INFO - PID 1985 | |10;stanford-crypto-aes;73;75;71;72;73;72;72;71;76;72 17:50:01 INFO - PID 1985 | |11;stanford-crypto-ccm;109;107;113;113;109;106;111;108;112;111 17:50:01 INFO - PID 1985 | |12;stanford-crypto-pbkdf2;161;158;163;159;159;159;159;157;159;160 17:50:01 INFO - PID 1985 | |13;stanford-crypto-sha256-iterative;63;66;65;65;62;63;62;68;61;62 17:50:01 INFO - PID 1985 | __end_tp_report 17:50:01 INFO - PID 1985 | __start_cc_report 17:50:01 INFO - PID 1985 | _x_x_mozilla_cycle_collect,761 17:50:01 INFO - PID 1985 | __end_cc_report 17:50:01 INFO - PID 1985 | __startTimestamp1506991801198__endTimestamp 17:50:01 INFO - PID 1985 | 17:50:01 INFO - PID 1985 | ------- Summary: start ------- 17:50:01 INFO - PID 1985 | Number of tests: 14 17:50:01 INFO - PID 1985 | 17:50:01 INFO - PID 1985 | [#0] ai-astar Cycles:10 Average:106.90 Median:107.00 stddev:1.52 (1.4%) stddev-sans-first:1.62 17:50:01 INFO - PID 1985 | Values: 107.0 106.0 105.0 107.0 105.0 110.0 106.0 108.0 108.0 107.0 17:50:01 INFO - PID 1985 | 17:50:01 INFO - PID 1985 | [#1] audio-beat-detection Cycles:10 Average:116.50 Median:116.50 stddev:1.58 (1.4%) stddev-sans-first:1.67 17:50:01 INFO - PID 1985 | Values: 116.0 115.0 117.0 118.0 115.0 117.0 115.0 120.0 116.0 116.0 17:50:01 INFO - PID 1985 | 17:50:01 INFO - PID 1985 | [#2] audio-dft Cycles:10 Average:163.50 Median:163.00 stddev:2.07 (1.3%) stddev-sans-first:2.19 17:50:01 INFO - PID 1985 | Values: 163.0 163.0 164.0 162.0 162.0 164.0 163.0 162.0 163.0 169.0 17:50:01 INFO - PID 1985 | 17:50:01 INFO - PID 1985 | [#3] audio-fft Cycles:10 Average:74.70 Median:75.00 stddev:1.89 (2.5%) stddev-sans-first:1.94 17:50:01 INFO - PID 1985 | Values: 76.0 75.0 75.0 79.0 75.0 74.0 72.0 73.0 74.0 74.0 17:50:01 INFO - PID 1985 | 17:50:01 INFO - PID 1985 | [#4] audio-oscillator Cycles:10 Average:78.60 Median:79.00 stddev:0.52 (0.7%) stddev-sans-first:0.53 17:50:01 INFO - PID 1985 | Values: 79.0 79.0 79.0 78.0 78.0 79.0 79.0 78.0 78.0 79.0 17:50:01 INFO - PID 1985 | 17:50:01 INFO - PID 1985 | [#5] imaging-gaussian-blur Cycles:10 Average:113.10 Median:114.00 stddev:1.45 (1.3%) stddev-sans-first:1.50 17:50:01 INFO - PID 1985 | Values: 114.0 114.0 114.0 113.0 110.0 114.0 114.0 114.0 111.0 113.0 17:50:01 INFO - PID 1985 | 17:50:01 INFO - PID 1985 | [#6] imaging-darkroom Cycles:10 Average:149.10 Median:148.00 stddev:3.54 (2.4%) stddev-sans-first:0.71 17:50:01 INFO - PID 1985 | Values: 159.0 148.0 147.0 149.0 148.0 148.0 149.0 148.0 148.0 147.0 17:50:01 INFO - PID 1985 | 17:50:01 INFO - PID 1985 | [#7] imaging-desaturate Cycles:10 Average:94.20 Median:94.00 stddev:1.14 (1.2%) stddev-sans-first:1.20 17:50:01 INFO - PID 1985 | Values: 94.0 94.0 93.0 93.0 94.0 95.0 94.0 94.0 94.0 97.0 17:50:01 INFO - PID 1985 | 17:50:01 INFO - PID 1985 | [#8] json-parse-financial Cycles:10 Average:53.40 Median:53.00 stddev:1.26 (2.4%) stddev-sans-first:1.20 17:50:01 INFO - PID 1985 | Values: 55.0 53.0 52.0 53.0 53.0 53.0 53.0 52.0 54.0 56.0 17:50:01 INFO - PID 1985 | 17:50:01 INFO - PID 1985 | [#9] json-stringify-tinderbox Cycles:10 Average:37.80 Median:38.00 stddev:1.03 (2.7%) stddev-sans-first:1.09 17:50:01 INFO - PID 1985 | Values: 38.0 38.0 37.0 38.0 37.0 37.0 37.0 37.0 39.0 40.0 17:50:01 INFO - PID 1985 | 17:50:01 INFO - PID 1985 | [#10] stanford-crypto-aes Cycles:10 Average:72.70 Median:72.50 stddev:1.64 (2.3%) stddev-sans-first:1.73 17:50:01 INFO - PID 1985 | Values: 73.0 75.0 71.0 72.0 73.0 72.0 72.0 71.0 76.0 72.0 17:50:01 INFO - PID 1985 | 17:50:01 INFO - PID 1985 | [#11] stanford-crypto-ccm Cycles:10 Average:109.90 Median:111.00 stddev:2.47 (2.2%) stddev-sans-first:2.60 17:50:01 INFO - PID 1985 | Values: 109.0 107.0 113.0 113.0 109.0 106.0 111.0 108.0 112.0 111.0 17:50:01 INFO - PID 1985 | 17:50:01 INFO - PID 1985 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:159.40 Median:159.00 stddev:1.65 (1.0%) stddev-sans-first:1.64 17:50:01 INFO - PID 1985 | Values: 161.0 158.0 163.0 159.0 159.0 159.0 159.0 157.0 159.0 160.0 17:50:01 INFO - PID 1985 | 17:50:01 INFO - PID 1985 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.70 Median:64.00 stddev:2.21 (3.5%) stddev-sans-first:2.33 17:50:01 INFO - PID 1985 | Values: 63.0 66.0 65.0 65.0 62.0 63.0 62.0 68.0 61.0 62.0 17:50:01 INFO - PID 1985 | -------- Summary: end -------- 17:50:01 INFO - PID 1985 | 17:50:01 INFO - PID 1985 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 17:50:01 INFO - TEST-INFO | 1985: exit 0 17:50:01 INFO - TEST-OK | kraken | took 60426ms 17:50:01 INFO - SUITE-END | took 1169s 17:50:02 INFO - Completed test suite (00:19:30) 17:50:02 INFO - javascript benchmark 17:50:02 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s", "stylo_disabled"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8534.744871192812, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3214.132184310236, 3221.3235220603674, 3241.108695108843, 3244.059222825381, 3270.0516850113468, 6233.906491402633, 6280.497560195185, 6284.0, 6371.139896114029, 6413.422791948724, 6289.402506761861, 6335.113084168209, 6345.0, 6446.194225721785, 6464.321246269133, 5734.397888221739, 5833.737481813318, 5844.0, 5909.6158749681135, 5971.5222782177325, 5687.516561092312, 5793.565482588801, 5870.26621672291, 5893.086571581412, 5910.0, 5782.566307526931, 5807.651540907538, 5814.912776308359, 5823.388544202882, 5826.708664566755, 5777.45114214149, 5830.883382332329, 5833.06670932653, 5839.445252700986, 5912.526997840206, 5762.394948530427, 5798.391168927286, 5847.093700476433, 5863.0, 5881.794137205177, 6227.657478838662, 6319.74721011159, 6336.46140078094, 6413.486921046305, 6464.159659244315, 6834.931650683479, 6873.20958089821, 6876.587404755681, 6881.621510816903, 6900.482463815234, 6851.1778586569435, 6853.383195512428, 6912.377885990285, 6932.584044957268, 6965.547239429421, 6238.2825975013, 6247.7188526515965, 6300.527460440485, 6328.303886572473, 6334.049892516114, 6952.026716259727, 6952.409045231111, 6956.930430695729, 6959.338862808025, 6971.058907047585, 6501.122348482894, 6531.216254049545, 6616.569922954993, 6624.701888415033, 6667.6666166691475, 6789.592624442549, 6836.316368363124, 6848.075509806113, 6864.48516361265, 6865.8328084225805, 6771.492138089663, 6772.187337519529, 6823.829404264933, 6853.93763966586, 6866.073080134218, 6670.566413183127, 6771.052052712625, 6792.694328755218, 6816.216135144423, 6913.75801846933, 5364.9731751341, 5369.704666243394, 5371.75827087782, 5377.596680248997, 5384.165454354581, 4706.670533062653, 4713.552212539803, 4754.809807607726, 4773.546513081252, 4783.067301876101, 5856.502197313276, 5869.882602347929, 5878.2358293421585, 5939.821805345847, 5951.285845698458, 6680.599164050075, 6782.389584937379, 6787.355201255873, 6843.3840954314355, 6939.271376505394, 5765.019946609086, 5769.307683077974, 5777.277840269966, 5803.100519419497, 5866.911996320058, 5681.829545113653, 5767.077267637158, 5767.394423585547, 5777.104548794943, 5782.045962416239, 6458.838529036811, 6528.934710652928, 6583.703733332011, 6606.240282367493, 6611.272759996396, 6690.698918548775, 6750.797476075725, 6790.354916282945, 6803.659817009031, 6816.0457535946, 6480.805575832733, 6533.575317604341, 6545.738170473128, 6561.0, 6601.9009714853355, 6592.241892182268, 6723.596584204964, 6728.158980127484, 6728.764493242713, 6755.054292399166, 6771.085903403175, 6788.355106265094, 6803.625800581016, 6852.314768523307, 6860.0, 6440.967795160994, 6540.476761858945, 6546.443552298108, 6623.105880706235, 6629.8729216032425, 6565.244996825426, 6567.2447668518735, 6686.7993960181275, 6690.531662783753, 6693.598384096969, 6485.513586481127, 6486.740530378732, 6574.76988305407, 6587.341265873374, 6601.669916504059, 6609.074729537772, 6618.271990080991, 6627.204735431779, 6691.46468282546, 6721.395074443323, 6250.687465626791, 6258.624482531062, 6338.58799178052, 6348.714307856065, 6441.420272175526], "value": 6187.895441376961, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [859.4027151129965, 873.0919843362902, 878.9736307910761, 880.3837313880285, 884.3190743127793, 38406.11954103439, 39280.0, 41789.37315940263, 42105.368419473656, 42149.36775948363, 37706.0573485663, 37847.0, 37937.62062379375, 37994.810025949904, 38217.0, 7118.822029449279, 7245.6377181141, 7247.565146091251, 7249.927500724978, 7279.781606551812, 7186.245444228359, 7226.349628533431, 7248.021517095203, 7279.3812525935355, 7286.417086633083, 7210.0, 7233.746818861341, 7271.309225623558, 7750.806229844243, 7995.200479952016, 7879.212078792132, 7959.761207163794, 7978.720744773963, 7982.720604778805, 7996.280334769898, 7785.844283114363, 7843.568603726792, 7885.566293853835, 7911.564863932482, 7915.643796029192, 38988.61011389878, 39719.20561588781, 39768.20463590712, 39819.0, 39908.80045599782, 3573.1960308930543, 3598.9100272493397, 3621.257642183346, 3635.327464419091, 3635.6909662678704, 32782.83608581942, 32950.340993180245, 33012.17469563256, 33015.0, 33075.173120671934, 5255.894882102375, 5283.07546179417, 5307.2569840222395, 5319.308489896289, 5334.493223143795, 180572.0, 181763.0, 181971.0, 182505.0, 183030.0, 41712.79143604262, 42768.0, 48231.75884120557, 48394.0, 48499.0, 51726.0, 52180.47819521832, 52331.0, 52404.21393679098, 52530.0, 15923.840761592235, 16073.678526429407, 16080.195990200444, 16133.838661613469, 16207.918960405359, 13177.0, 13238.801417978739, 13248.602541923758, 13255.933720331337, 13268.203907765565, 14084.647883802987, 14108.224047677271, 14191.64520886986, 14206.218657973704, 14296.356663950148, 5871.647701137946, 5883.676397798076, 5927.1405646181065, 5946.851328716817, 5976.850578735566, 1006.8389057750871, 1020.0462567499412, 1022.7238645565656, 1025.661531694554, 1031.0668844695563, 22823.31530054068, 22897.548366492498, 23127.537449251256, 23180.0, 23400.18099366548, 1109.9500522476508, 1116.810142275815, 1121.3103941076179, 1130.960416385439, 1131.5360702112096, 11904.761904761855, 12055.57805476804, 12190.756184876253, 12255.142140050111, 12309.50761969529, 227734.0, 228342.0, 229096.0, 230486.0, 230794.0, 51115.233271500954, 51402.48597513977, 51678.22482662763, 51762.0, 51908.74045629748, 1410.3864818803647, 1450.0791997081717, 1457.9489717859824, 1474.1670955909876, 1477.143256910989, 22634.320970370914, 22661.660075098556, 22711.545769084856, 22962.31113066611, 22986.195483158008, 31051.22371940629, 31321.0, 31612.0, 31622.841885790425, 31821.522677160323, 192504.0, 192777.0, 193047.0, 193473.0, 193813.0, 33909.830450847585, 34455.483167752005, 36134.457983129745, 36306.27387452289, 36420.27159456849, 43689.78155109204, 44957.55042449533, 45103.0, 45194.77402612966, 45401.772991134836, 33233.33533329368, 33281.500777487876, 33467.66532334645, 33473.16317091995, 33674.83162584171, 33095.33809323848, 33309.33381332408, 33388.666113339525, 33559.32881342409, 33585.66414335923, 37327.0, 37450.250994979404, 37492.0, 37616.43575346427, 37710.0, 32205.838970804994, 32236.83881580671, 32373.67626323801, 32506.187345316557, 32676.34647307088, 23749.05003799898, 23990.28029159128, 24204.87897560501, 24253.878730606233, 24308.635370469812], "value": 17128.45795374769, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [584.7456356484929, 587.3861814403947, 595.2321505258217, 596.5227817745803, 597.961132526386, 21816.236431724894, 21906.342809715694, 22759.089636414545, 22798.08807647692, 22826.31521054371, 25583.488330233384, 26108.869455652744, 26187.476250474978, 26200.641942225197, 26242.343941401476, 6663.700133494004, 6778.08495853061, 6782.593044417326, 6785.710714964166, 6808.251092379859, 6541.116949211867, 6708.262091169968, 7185.89221161683, 7191.388731957763, 7213.89179162313, 7115.537490063155, 7183.604901730403, 7187.029750983603, 7189.640517974107, 7190.856182876366, 7141.0, 7142.21435642079, 7180.784576462688, 7183.353498185163, 7194.928050719478, 7015.789526314219, 7017.0877785888015, 7034.0, 7040.577565346044, 7044.401225895805, 28730.856345718137, 29716.257093572618, 30561.847190764125, 30751.538726919112, 30803.229919251975, 2121.5226574020876, 2167.349795061491, 2167.7398712154486, 2173.6848157017303, 2193.254293540188, 19706.70439943402, 20048.498787530283, 20068.397948061436, 20090.497737556532, 20116.79883201164, 2475.2450502596703, 2509.473010667762, 2577.6133579963157, 2657.8139530232893, 2665.8400495970304, 143648.0, 149061.0, 149162.25418872945, 149427.0, 149483.0, 19503.707444388347, 20517.58964820695, 21694.566108677736, 21769.891150544147, 22962.770372296396, 22934.541309174056, 24425.0, 43431.56568434275, 43480.78259608745, 43910.78044609757, 10058.295919285727, 10086.899131008742, 10157.593696252066, 10169.644062457779, 10382.117520010732, 9120.315976301805, 9201.159768046418, 9246.26029917605, 9304.90695093054, 9346.345755797165, 9299.488528131018, 9380.296477764196, 9511.952440237754, 9580.0898914603, 9619.450845525942, 2602.375429896811, 2628.5925681519393, 2642.656454660882, 2675.1305825606755, 2693.7540263981855, 963.6579014449769, 986.4475893499663, 987.5407935310116, 989.2877128467492, 1001.7595777013464, 18989.430317090508, 19073.2370705173, 19245.903770481058, 19711.60576788456, 19863.801361986483, 1056.4770438632927, 1062.8033813744482, 1069.0, 1070.9196810239264, 1075.8493810866485, 10519.737006574896, 10631.922735035794, 10652.57389704403, 10714.303570268063, 11016.17378696601, 451554.0, 460651.0, 469565.0, 470059.0, 472195.0, 110456.0, 114288.42855785668, 114338.0, 114814.0, 114910.42544787223, 1196.9102317326235, 1201.0511695760426, 1206.0713250797012, 1209.4920133543933, 1222.419350808359, 16751.664966700842, 17323.133843308035, 17528.123593820514, 17684.646307074043, 17767.822321777134, 54138.458615414915, 56051.0, 56063.0, 57471.0, 58514.70742646259, 69469.65265173641, 69809.65095174492, 70163.29836701568, 70833.29166708473, 71078.28921710717, 14443.927780361031, 14594.489192878198, 14659.193744344164, 14679.0, 14726.63183420423, 22214.777852221272, 22255.0, 22334.329970100924, 22569.548609028057, 22700.432489187904, 17801.1989460472, 17904.91047544754, 18010.90994545019, 18110.72833907466, 18211.180496877936, 13992.720145597235, 14198.148111113367, 14273.0, 15089.773653394988, 15362.30869610848, 18505.629887402447, 18628.534286642942, 18672.346467873558, 18806.811931881053, 18899.433017009513, 13803.654908627364, 14365.7845132321, 14574.417023318949, 14585.489507867174, 14617.853821462075, 17562.12189390551, 17595.0, 17935.73096403529, 18001.0, 18019.639607208046], "value": 12367.268409532804, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1283.8266833977411, 1345.5559665310448, 1346.0683918576838, 1346.710457251691, 1348.7167694784089, 14607.926960365197, 15031.398744050224, 15037.924810375947, 15078.547643570682, 15086.019408738439, 14609.634759131028, 14778.482753103617, 14787.704245915074, 14788.778168327484, 14828.258587070657, 2790.4000639862425, 2799.7340252675963, 2835.688074311824, 2836.3618185908213, 2842.3036356092784, 2673.17131689177, 2765.308672831792, 2774.8057635965492, 2781.3741908070624, 2785.7214278572183, 2611.3602167468903, 2735.4529094181144, 2841.6447944007, 2855.457463082018, 2859.2851787053237, 2799.3281612412875, 2827.0953294945625, 2851.2159156231996, 2857.6142220800134, 2859.0, 2796.734310240524, 2800.369916768731, 2817.7182281771866, 2836.248394175545, 2840.5171120909495, 14916.179610121439, 15162.0, 15166.31751571171, 15184.468543601031, 15211.0, 7948.244916732901, 8140.3487720982175, 8240.0, 8262.297704695107, 8262.545559994198, 5097.2608971699265, 5169.198774190007, 5211.478852114758, 5287.762050707689, 5440.6735595864375, 1878.4928069421317, 1885.5945971616168, 1889.1782074797507, 1928.623918335925, 1934.3616606519815, 26795.0, 26968.325791855164, 27197.184084477496, 27238.04666836651, 27252.59121113185, 6522.478201743849, 6618.205815302194, 6624.768133115318, 6799.4900382471515, 6850.0752398425575, 17811.46565603008, 17871.553211169823, 17879.642407152045, 17890.91054544745, 17894.91052544729, 7915.089764677021, 8243.2581067703, 8245.546494942715, 8260.504369737835, 8275.420720549624, 7221.963890180516, 7327.633618319062, 7343.816404589928, 7409.592472413961, 7413.2957369049855, 5083.364579427572, 5262.079136151235, 5262.236975638511, 5281.0, 5297.470252974749, 1323.4176962136628, 1340.5911197084788, 1409.8378686450985, 1436.080908218741, 1456.8615981481742, 775.0892701076212, 810.4974915552277, 812.4110020235282, 816.8856360109589, 819.8073452738602, 7429.33136017761, 7628.46600737943, 7653.272939070779, 7681.155072941972, 7690.73082442123, 715.8389362393524, 728.3663213004614, 736.4219088015882, 803.2569872867574, 827.2678679368681, 4507.166174257773, 4541.500434952152, 4625.468071171791, 4767.094252092161, 4862.489438608965, 20892.686609700868, 21213.939303034786, 21304.467388315104, 21342.253021144184, 21535.353939381843, 20989.68515472269, 21251.46871328198, 22113.55772884533, 22333.441663958205, 22743.431414214778, 10799.920007999137, 11206.887931120747, 11248.550057997589, 11264.267822591506, 11416.486258118404, 7141.250168732208, 7278.417726581966, 7342.265773422615, 7398.593077380796, 7443.44174186949, 18223.0, 18800.905995469937, 18874.811251887306, 19341.4197574073, 19497.512562186057, 19256.807431925503, 19425.222991080198, 19511.804881951, 19656.21375144978, 19677.606447870676, 11103.444827758742, 11278.210525263154, 11362.886371136183, 11378.658640240807, 11382.54469821198, 13943.233122178377, 14029.3686784097, 14106.435742570182, 14120.0, 14127.858721413066, 11359.943200283946, 11527.827082593936, 11578.0, 11688.88311116878, 11833.349165795964, 11239.719007024889, 11279.7744045117, 11355.659330220107, 11384.43077846121, 11559.942200288944, 9487.09872562133, 9521.047895210424, 9606.66376676841, 9616.990216027496, 9628.66299679508, 6845.386782838025, 6913.10129683138, 7029.507934444744, 7057.6471176439945, 7073.2219455858785, 7013.2986701329455, 7029.156501219886, 7043.823904402226, 7075.929240707733, 7118.857622847618], "value": 6570.982707581056, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [506.5188071332233, 519.2444992535859, 539.7193459401111, 542.3139728243775, 546.6719968019188, 6199.907001394983, 6269.7492100315985, 6269.780557680482, 6291.33940936202, 6372.745090196387, 6132.693365331738, 6160.815175544741, 6216.191895053648, 6226.688665566726, 6237.906431403521, 5180.870478238036, 5190.844274671766, 5205.947940520584, 5220.504052115043, 5230.816921407752, 4864.805407783702, 5002.349694539705, 5173.741312934357, 5177.844664660048, 5206.869828254286, 4943.060818444502, 4979.8008079676765, 4983.900321993558, 4988.052270068675, 4988.451270360258, 4965.478624744404, 4986.82546110888, 4987.950120498785, 4999.400071991385, 5020.447750747415, 4376.518582955872, 4462.330650402433, 4466.0, 4484.618807401374, 4490.0, 6049.758009679607, 6061.636301821904, 6098.176746139259, 6113.44978951892, 6126.509879209652, 5684.715764211773, 5699.2590963174935, 5720.22776925114, 5721.4850663440075, 5730.312362516524, 6528.11870397495, 6544.803655890331, 6552.180977377828, 6563.803085907431, 6579.769708060243, 4699.976500117477, 4913.164761990471, 4914.164592019365, 4920.8769780755765, 4936.160852655057, 6566.8358291043105, 6587.637679927602, 6814.318568143196, 6846.589204647687, 6848.178218613699, 4990.600751939836, 5018.222175562721, 5028.245763135559, 5030.673006254582, 5037.546620804145, 5059.988002399535, 5064.848054558369, 5084.618653600995, 5090.720010399389, 5105.923411148836, 5667.829965101054, 5687.146927960839, 5695.430456954355, 5716.628419152825, 5744.253247077853, 6511.544191906521, 6591.703373348115, 6594.505412094112, 6604.669766511655, 6613.933860661428, 1748.728947013215, 1761.6917039518032, 1767.1782621081259, 1778.457570441002, 1791.2924394864217, 1167.1363191238422, 1223.1376879300071, 1230.0, 1237.6287113865803, 1262.6174339098673, 5610.607257492018, 5627.199296225169, 5645.604807663424, 5653.858653533694, 5654.476418864974, 6336.936630633634, 6543.640099794462, 6552.279249282575, 6669.966650166718, 6674.666266686646, 5582.944170558324, 5593.244911936918, 5594.776208951596, 5617.9719101404235, 5643.35101463337, 3459.9481007784902, 3472.913177170591, 3506.298740251909, 3530.805805680712, 3563.4120370138635, 6381.744730210739, 6452.483801295885, 6507.967460162668, 6510.348965103546, 6523.804285871432, 6753.662316884136, 6817.488688348394, 6819.465620235407, 6876.965615171992, 6911.203087197265, 6459.935400645933, 6461.709223084972, 6467.611943283418, 6501.609903405716, 6506.527519542638, 6651.50113741481, 6702.899456508254, 6708.899366509604, 6752.527323087336, 6806.319368063154, 6687.264400915798, 6687.264400915993, 6706.195256569243, 6721.899171512334, 6725.932740672726, 6459.0, 6478.2550006749825, 6517.902231466437, 6532.967335163294, 6556.442702370352, 5042.092423363683, 5044.695724300443, 5065.366829146356, 5068.695878247317, 5078.949210507848, 6388.96805515988, 6556.0, 6621.205455345389, 6779.389854913082, 6791.830204244933, 6130.938690613215, 6379.457746091634, 6430.967845160932, 6444.4844412445955, 6491.870162596816, 6371.39471750183, 6422.3577642235405, 6472.320406357265, 6473.158489396348, 6496.480281577557, 6182.258129024546, 6299.0, 6324.110671936818, 6366.554341196072, 6436.517261205522, 6413.16628838248, 6470.22357317125, 6475.967620161869, 6505.447037001908, 6555.147830781968, 6201.441870231701, 6257.53068519872, 6273.278572964167, 6325.557210995186, 6337.493000560036], "value": 5047.372124878518, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [906.0622255965078, 918.6646873891029, 943.1841457139576, 943.6508491858009, 955.3408148377619, 19660.311889083885, 20370.59258814823, 20424.489387765312, 20470.2835400761, 20487.18051277949, 19088.71366929497, 19211.807881921177, 19554.31559895404, 19594.412167634957, 19920.800791992075, 957.1385752822463, 969.1713584884927, 971.7036303927299, 971.7764914069768, 974.3374505336368, 955.1785464500524, 1000.8548760429734, 1003.14231332211, 1003.5784970312486, 1003.6136087606251, 1051.3324039235065, 1062.941538215398, 1063.2132222155587, 1063.9893601064007, 1064.0476773287942, 1056.7252514346249, 1058.227493929436, 1059.5285098131296, 1059.7986382587283, 1060.178361769627, 732.454321530458, 738.9408847292258, 752.8494301139739, 754.1591125894643, 769.8229407236311, 20301.0, 20315.984200789902, 20436.0, 20439.591208175752, 20513.794862051338, 21406.357809265748, 21509.354719358445, 22369.440763980867, 22549.436264093365, 22555.774442255697, 13679.658008549866, 13830.792538111937, 13858.16850988944, 13944.16335019902, 14046.297685115806, 3798.1833905710405, 3812.1041555234497, 3812.1803812180237, 3815.084379748868, 3823.541175058983, 125542.0, 127825.0, 128043.35978320049, 129487.0, 129698.0, 16936.0, 17057.147142642818, 17244.482665520056, 17270.13649317529, 17395.304187832597, 31110.22224444407, 31199.22001949924, 31670.36659266802, 31874.0, 31904.840475797937, 8861.64553417869, 9060.728178154666, 9063.954680226689, 9064.954675226714, 9067.04795996411, 4112.773797441169, 4131.462909821704, 4159.272127377697, 4161.708680392404, 4164.604362585549, 4875.049365373789, 4920.065187614342, 4943.0, 4965.031818795373, 5003.2745251938995, 984.4093543873619, 991.0733464210986, 995.8506224066304, 1000.7298029531986, 1003.7841863999275, 671.1711036869463, 677.3260605697265, 694.982625434358, 697.7034760226883, 702.4380495603497, 11680.357580332993, 11895.70260743471, 12076.154669173073, 12963.0, 13247.271400072896, 674.1337381464795, 681.877262092828, 684.7021545627667, 694.3438450664175, 697.6965020216222, 5262.10544207478, 5273.78904843802, 5278.736063196901, 5281.781651706293, 5314.70769107695, 118330.0, 118486.0, 118710.0, 119958.0, 123914.38042809728, 106848.93151068545, 109196.0, 109682.45158774155, 110276.0, 114963.0, 93802.53098734462, 95177.52411237899, 95764.52117739366, 96955.0, 97418.0, 9942.900570994198, 9948.502574871083, 9962.352447090916, 9980.900190997998, 10119.392836429837, 44972.325415118146, 45255.32117018313, 45667.54332456766, 46933.76533117313, 47677.0, 56047.0, 57639.711801440724, 57886.0, 58003.0, 59906.0, 14661.266936653337, 14950.25248737537, 14953.177575233032, 15061.246937652855, 15080.773788393402, 17272.395466159127, 17725.0, 17755.644887102444, 17766.911165444606, 17767.20047597887, 14691.55925322242, 14729.337179827147, 14764.0, 14827.92586037063, 14859.034162779384, 15629.609259768597, 15796.76304855451, 15908.761368579711, 16053.277602507682, 16109.275082621076, 15119.622009449851, 15230.23848807533, 15245.16151611672, 15469.922650386676, 15501.84498155004, 12081.516739330329, 12153.1492795507, 12475.625731228078, 12487.12590118683, 12534.373281335715, 12745.808812867628, 12817.87182128204, 12834.97320214362, 12896.677583060498, 13175.07774455779], "value": 8889.682787132877, "unit": "score"}]}, {"extraOptions": ["e10s", "stylo_disabled"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1393.5000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 106.0, 105.0, 107.0, 105.0, 110.0, 106.0, 108.0, 108.0, 107.0], "value": 106.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 115.0, 117.0, 118.0, 115.0, 117.0, 115.0, 120.0, 116.0, 116.0], "value": 116.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 163.0, 164.0, 162.0, 162.0, 164.0, 163.0, 162.0, 163.0, 169.0], "value": 163.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 75.0, 79.0, 75.0, 74.0, 72.0, 73.0, 74.0, 74.0], "value": 74.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 79.0, 79.0, 78.0, 78.0, 79.0, 79.0, 78.0, 78.0, 79.0], "value": 78.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 114.0, 113.0, 110.0, 114.0, 114.0, 114.0, 111.0, 113.0], "value": 113.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 148.0, 147.0, 149.0, 148.0, 148.0, 149.0, 148.0, 148.0, 147.0], "value": 149.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 93.0, 93.0, 94.0, 95.0, 94.0, 94.0, 94.0, 97.0], "value": 94.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 53.0, 52.0, 53.0, 53.0, 53.0, 53.0, 52.0, 54.0, 56.0], "value": 53.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [38.0, 38.0, 37.0, 38.0, 37.0, 37.0, 37.0, 37.0, 39.0, 40.0], "value": 37.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 75.0, 71.0, 72.0, 73.0, 72.0, 72.0, 71.0, 76.0, 72.0], "value": 72.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 107.0, 113.0, 113.0, 109.0, 106.0, 111.0, 108.0, 112.0, 111.0], "value": 109.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 158.0, 163.0, 159.0, 159.0, 159.0, 159.0, 157.0, 159.0, 160.0], "value": 159.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 66.0, 65.0, 65.0, 62.0, 63.0, 62.0, 68.0, 61.0, 62.0], "value": 63.7, "unit": "score"}]}]} 17:50:02 INFO - Return code: 0 17:50:02 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 17:50:02 INFO - # TBPL SUCCESS # 17:50:02 INFO - Running post-action listener: _package_coverage_data 17:50:02 INFO - Running post-action listener: _resource_record_post_action 17:50:02 INFO - [mozharness: 2017-10-03 00:50:02.494942Z] Finished run-tests step (success) 17:50:02 INFO - Running post-run listener: _resource_record_post_run 17:50:02 INFO - Total resource usage - Wall time: 1188s; CPU: 13.0%; Read bytes: 8192; Write bytes: 337002496; Read time: 172; Write time: 192404 17:50:02 INFO - TinderboxPrint: CPU usage
13.1% 17:50:02 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 172 17:50:02 INFO - TinderboxPrint: I/O write bytes / time
337,002,496 / 192,404 17:50:02 INFO - TinderboxPrint: CPU idle
8,230.3 (86.9%) 17:50:02 INFO - TinderboxPrint: CPU user
1,193.7 (12.6%) 17:50:02 INFO - TinderboxPrint: Swap in / out
0 / 0 17:50:02 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 13344768; Read time: 0; Write time: 2540 17:50:02 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 17:50:02 INFO - run-tests - Wall time: 1171s; CPU: 13.0%; Read bytes: 8192; Write bytes: 323657728; Read time: 172; Write time: 189864 17:50:03 INFO - Running post-run listener: _upload_blobber_files 17:50:03 INFO - Blob upload gear active. 17:50:03 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:50:03 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 17:50:03 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-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 17:50:03 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-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 17:50:03 INFO - (blobuploader) - INFO - Open directory for files ... 17:50:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 17:50:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:50:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:50:04 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 17:50:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:50:04 INFO - (blobuploader) - INFO - Done attempting. 17:50:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 17:50:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:50:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:50:08 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 17:50:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:50:08 INFO - (blobuploader) - INFO - Done attempting. 17:50:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log ... 17:50:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:50:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:50:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_raw.log: uploaded 17:50:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:50:09 INFO - (blobuploader) - INFO - Done attempting. 17:50:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log ... 17:50:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:50:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:50:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_errorsummary.log: uploaded 17:50:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:50:10 INFO - (blobuploader) - INFO - Done attempting. 17:50:10 INFO - (blobuploader) - INFO - Iteration through files over. 17:50:10 INFO - Return code: 0 17:50:10 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:50:10 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:50:10 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e24d6d9518a7d00a95bbe98b31918783d970483cdcb88639c423c5a3abfada8b7d8f00ef38fd27bfdf80eb51075acb9b67eee8c2e36e827fb9c2af0e19c10898", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1a9138ef3c2d5219388a22723f36c7290a9716dc31560d7d246377c1ab477b3c48cefb7a684a35f8e7631a3d7e075361aa1d2102c0571212aed78f243005e99e", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5550679c35794230fc8666dbe92cbaaefb3085426cc941763253df50107033a398ab1ca63310b5f468bc2a1487bbcb7f5fbfae7607edad0f61100cd8802f6c15", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6734018764340d0723f7cd35f9d78f5f1d99bc223e3770713c900c43ef4c80a9882876e1c47b6ff5c1ed2f478fca7743eecc04146017b8ca48805448481eb009"} 17:50:10 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:50:10 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:50:10 INFO - Contents: 17:50:10 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e24d6d9518a7d00a95bbe98b31918783d970483cdcb88639c423c5a3abfada8b7d8f00ef38fd27bfdf80eb51075acb9b67eee8c2e36e827fb9c2af0e19c10898", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1a9138ef3c2d5219388a22723f36c7290a9716dc31560d7d246377c1ab477b3c48cefb7a684a35f8e7631a3d7e075361aa1d2102c0571212aed78f243005e99e", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5550679c35794230fc8666dbe92cbaaefb3085426cc941763253df50107033a398ab1ca63310b5f468bc2a1487bbcb7f5fbfae7607edad0f61100cd8802f6c15", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6734018764340d0723f7cd35f9d78f5f1d99bc223e3770713c900c43ef4c80a9882876e1c47b6ff5c1ed2f478fca7743eecc04146017b8ca48805448481eb009"} 17:50:10 INFO - Running post-run listener: copy_logs_to_upload_dir 17:50:10 INFO - Copying logs to upload dir... 17:50:10 INFO - mkdir: /builds/slave/test/build/upload/logs 17:50:10 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1235.714829 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2017-10-02 17:50:10.376786) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-10-02 17:50:10.381051) ========= 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=9bfb7e13875ed353a705960e000001c0-1506988797.877462-1087527954 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-Non-PGO/sha512/e24d6d9518a7d00a95bbe98b31918783d970483cdcb88639c423c5a3abfada8b7d8f00ef38fd27bfdf80eb51075acb9b67eee8c2e36e827fb9c2af0e19c10898", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1a9138ef3c2d5219388a22723f36c7290a9716dc31560d7d246377c1ab477b3c48cefb7a684a35f8e7631a3d7e075361aa1d2102c0571212aed78f243005e99e", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5550679c35794230fc8666dbe92cbaaefb3085426cc941763253df50107033a398ab1ca63310b5f468bc2a1487bbcb7f5fbfae7607edad0f61100cd8802f6c15", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6734018764340d0723f7cd35f9d78f5f1d99bc223e3770713c900c43ef4c80a9882876e1c47b6ff5c1ed2f478fca7743eecc04146017b8ca48805448481eb009"} build_url:https://queue.taskcluster.net/v1/task/Hy3hXRK2T5ipTB-nz_T5Yw/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011383 build_url: 'https://queue.taskcluster.net/v1/task/Hy3hXRK2T5ipTB-nz_T5Yw/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e24d6d9518a7d00a95bbe98b31918783d970483cdcb88639c423c5a3abfada8b7d8f00ef38fd27bfdf80eb51075acb9b67eee8c2e36e827fb9c2af0e19c10898", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1a9138ef3c2d5219388a22723f36c7290a9716dc31560d7d246377c1ab477b3c48cefb7a684a35f8e7631a3d7e075361aa1d2102c0571212aed78f243005e99e", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5550679c35794230fc8666dbe92cbaaefb3085426cc941763253df50107033a398ab1ca63310b5f468bc2a1487bbcb7f5fbfae7607edad0f61100cd8802f6c15", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6734018764340d0723f7cd35f9d78f5f1d99bc223e3770713c900c43ef4c80a9882876e1c47b6ff5c1ed2f478fca7743eecc04146017b8ca48805448481eb009"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-10-02 17:50:10.412698) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-10-02 17:50:10.413075) ========= 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=9bfb7e13875ed353a705960e000001c0-1506988797.877462-1087527954 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004474 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-10-02 17:50:10.497659) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-10-02 17:50:10.497971) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-10-02 17:50:10.498263) ========= ========= Total master_lag: 0.24 =========