builder: mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s slave: talos-linux64-ix-062 starttime: 1505305170.43 results: success (0) revision: 1888ec2f277f6bb26271b8808e08914a21db9efe ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-13 05:19:30.426780) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-13 05:19:30.427154) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-13 05:19:30.427491) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-13 05:19:30.526473) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-13 05:19:30.526721) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1505300237.672302-631552636 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-13 05:19:30-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.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% 225M=0s 2017-09-13 05:19:30 (225 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.132791 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-13 05:19:30.679098) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-13 05:19:30.679391) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1505300237.672302-631552636 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017842 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-13 05:19:30.734902) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-13 05:19:30.735265) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 1888ec2f277f6bb26271b8808e08914a21db9efe --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 1888ec2f277f6bb26271b8808e08914a21db9efe --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=a4ce256d2ec601f24a60a71e000001bc-1505300237.672302-631552636 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-13 05:19:30,785 truncating revision to first 12 chars 2017-09-13 05:19:30,785 Setting DEBUG logging. 2017-09-13 05:19:30,785 attempt 1/10 2017-09-13 05:19:30,785 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/1888ec2f277f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-13 05:19:31,195 unpacking tar archive at: mozilla-central-1888ec2f277f/testing/mozharness/ program finished with exit code 0 elapsedTime=0.693043 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-13 05:19:31.445210) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-13 05:19:31.445537) ========= script_repo_revision: 1888ec2f277f6bb26271b8808e08914a21db9efe ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-13 05:19:31.445978) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-13 05:19:31.446285) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-13 05:19:31.464882) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2017-09-13 05:19:31.465248) ========= /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=a4ce256d2ec601f24a60a71e000001bc-1505300237.672302-631552636 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:19:31 INFO - MultiFileLogger online at 20170913 05:19:31 in /builds/slave/test 05:19:31 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 05:19:31 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:19:31 INFO - {'append_to_log': False, 05:19:31 INFO - 'base_work_dir': '/builds/slave/test', 05:19:31 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 05:19:31 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:19:31 INFO - 'branch': 'Firefox-Non-PGO', 05:19:31 INFO - 'buildbot_json_path': 'buildprops.json', 05:19:31 INFO - 'code_coverage': False, 05:19:31 INFO - 'config_files': ('talos/linux_config.py',), 05:19:31 INFO - 'default_actions': ('clobber', 05:19:31 INFO - 'read-buildbot-config', 05:19:31 INFO - 'download-and-extract', 05:19:31 INFO - 'populate-webroot', 05:19:31 INFO - 'create-virtualenv', 05:19:31 INFO - 'install', 05:19:31 INFO - 'setup-mitmproxy', 05:19:31 INFO - 'run-tests'), 05:19:31 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:19:31 INFO - 'disable_ccov_upload': False, 05:19:31 INFO - 'disable_stylo': False, 05:19:31 INFO - 'download_minidump_stackwalk': True, 05:19:31 INFO - 'download_symbols': 'ondemand', 05:19:31 INFO - 'enable_stylo': False, 05:19:31 INFO - 'enable_webrender': False, 05:19:31 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 05:19:31 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:19:31 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:19:31 INFO - 'gecko_profile': False, 05:19:31 INFO - 'gecko_profile_interval': 0, 05:19:31 INFO - 'installer_path': 'installer.exe', 05:19:31 INFO - 'log_level': 'info', 05:19:31 INFO - 'log_name': 'talos', 05:19:31 INFO - 'log_to_console': True, 05:19:31 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:19:31 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:19:31 INFO - 'opt_config_files': (), 05:19:31 INFO - 'pip_index': False, 05:19:31 INFO - 'suite': 'dromaeojs-stylo-disabled-e10s', 05:19:31 INFO - 'system_bits': '32', 05:19:31 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:19:31 INFO - 'title': 'talos-linux64-ix-062', 05:19:31 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:19:31 INFO - 'use_talos_json': True, 05:19:31 INFO - 'verify': 'False', 05:19:31 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:19:31 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:19:31 INFO - 'work_dir': 'build'} 05:19:31 INFO - [mozharness: 2017-09-13 12:19:31.663526Z] Running clobber step. 05:19:31 INFO - Running pre-action listener: _resource_record_pre_action 05:19:31 INFO - Running main action method: clobber 05:19:31 INFO - rmtree: /builds/slave/test/build 05:19:31 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:19:33 INFO - Running post-action listener: _resource_record_post_action 05:19:33 INFO - [mozharness: 2017-09-13 12:19:33.208294Z] Finished clobber step (success) 05:19:33 INFO - [mozharness: 2017-09-13 12:19:33.208393Z] Running read-buildbot-config step. 05:19:33 INFO - Running pre-action listener: _resource_record_pre_action 05:19:33 INFO - Running main action method: read_buildbot_config 05:19:33 INFO - Using buildbot properties: 05:19:33 INFO - { 05:19:33 INFO - "project": "", 05:19:33 INFO - "product": "firefox", 05:19:33 INFO - "who": "archaeopteryx@coole-files.de", 05:19:33 INFO - "installer_path": "public/build/target.tar.bz2", 05:19:33 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s", 05:19:33 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 05:19:33 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-stylo-disabled-e10s", 05:19:33 INFO - "stage_platform": "linux64", 05:19:33 INFO - "basedir": "/builds/slave/test", 05:19:33 INFO - "buildnumber": 16, 05:19:33 INFO - "platform": "ubuntu64_hw", 05:19:33 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 05:19:33 INFO - "slavebuilddir": "test", 05:19:33 INFO - "taskId": "I9V76IdbRzeSwXUcKSbezg", 05:19:33 INFO - "branch": "mozilla-central", 05:19:33 INFO - "script_repo_revision": "production", 05:19:33 INFO - "revision": "1888ec2f277f6bb26271b8808e08914a21db9efe", 05:19:33 INFO - "slavename": "talos-linux64-ix-062", 05:19:33 INFO - "repo_path": "mozilla-central" 05:19:33 INFO - } 05:19:33 INFO - Finding installer, test and symbols from parent task. 05:19:33 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/I9V76IdbRzeSwXUcKSbezg'}, attempt #1 05:19:33 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/I9V76IdbRzeSwXUcKSbezg'}, attempt #1 05:19:34 INFO - Task dependencies: DkoRCDt5TmCGOf_xf-Pg9A 05:19:34 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/DkoRCDt5TmCGOf_xf-Pg9A'}, attempt #1 05:19:34 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/DkoRCDt5TmCGOf_xf-Pg9A/artifacts/public/build/target.tar.bz2 05:19:34 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/DkoRCDt5TmCGOf_xf-Pg9A/artifacts/public/build/target.test_packages.json 05:19:34 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/DkoRCDt5TmCGOf_xf-Pg9A/artifacts/public/build/target.crashreporter-symbols.zip 05:19:34 INFO - Running post-action listener: _resource_record_post_action 05:19:34 INFO - [mozharness: 2017-09-13 12:19:34.553274Z] Finished read-buildbot-config step (success) 05:19:34 INFO - [mozharness: 2017-09-13 12:19:34.553493Z] Running download-and-extract step. 05:19:34 INFO - Running pre-action listener: _resource_record_pre_action 05:19:34 INFO - Running main action method: download_and_extract 05:19:34 INFO - mkdir: /builds/slave/test/build/tests 05:19:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:19:34 INFO - trying https://queue.taskcluster.net/v1/task/DkoRCDt5TmCGOf_xf-Pg9A/artifacts/public/build/target.test_packages.json 05:19:34 INFO - Downloading https://queue.taskcluster.net/v1/task/DkoRCDt5TmCGOf_xf-Pg9A/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 05:19:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/DkoRCDt5TmCGOf_xf-Pg9A/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 05:19:35 INFO - Downloaded 989 bytes. 05:19:35 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 05:19:35 INFO - Using the following test package requirements: 05:19:35 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 05:19:35 INFO - u'common': [u'target.common.tests.zip'], 05:19:35 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 05:19:35 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 05:19:35 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 05:19:35 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 05:19:35 INFO - u'mozbase': [u'target.common.tests.zip'], 05:19:35 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 05:19:35 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 05:19:35 INFO - u'web-platform': [u'target.common.tests.zip', 05:19:35 INFO - u'target.web-platform.tests.tar.gz'], 05:19:35 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 05:19:35 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 05:19:35 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/DkoRCDt5TmCGOf_xf-Pg9A/artifacts/public/build/target.common.tests.zip 05:19:35 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DkoRCDt5TmCGOf_xf-Pg9A/artifacts/public/build/target.common.tests.zip'}, attempt #1 05:19:35 INFO - Fetch https://queue.taskcluster.net/v1/task/DkoRCDt5TmCGOf_xf-Pg9A/artifacts/public/build/target.common.tests.zip into memory 05:19:36 INFO - Content-Length response header: 54566962 05:19:36 INFO - Bytes received: 54566962 05:19:47 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/DkoRCDt5TmCGOf_xf-Pg9A/artifacts/public/build/target.talos.tests.zip 05:19:47 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DkoRCDt5TmCGOf_xf-Pg9A/artifacts/public/build/target.talos.tests.zip'}, attempt #1 05:19:47 INFO - Fetch https://queue.taskcluster.net/v1/task/DkoRCDt5TmCGOf_xf-Pg9A/artifacts/public/build/target.talos.tests.zip into memory 05:19:48 INFO - Content-Length response header: 14499226 05:19:48 INFO - Bytes received: 14499226 05:19:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:19:48 INFO - trying https://queue.taskcluster.net/v1/task/DkoRCDt5TmCGOf_xf-Pg9A/artifacts/public/build/target.tar.bz2 05:19:48 INFO - Downloading https://queue.taskcluster.net/v1/task/DkoRCDt5TmCGOf_xf-Pg9A/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 05:19:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/DkoRCDt5TmCGOf_xf-Pg9A/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 05:19:50 INFO - Downloaded 61377180 bytes. 05:19:50 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/DkoRCDt5TmCGOf_xf-Pg9A/artifacts/public/build/target.tar.bz2 05:19:50 INFO - mkdir: /builds/slave/test/properties 05:19:50 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:19:50 INFO - Writing to file /builds/slave/test/properties/build_url 05:19:50 INFO - Contents: 05:19:50 INFO - build_url:https://queue.taskcluster.net/v1/task/DkoRCDt5TmCGOf_xf-Pg9A/artifacts/public/build/target.tar.bz2 05:19:50 INFO - Running post-action listener: _resource_record_post_action 05:19:50 INFO - Running post-action listener: find_tests_for_verification 05:19:50 INFO - Running post-action listener: set_extra_try_arguments 05:19:50 INFO - [mozharness: 2017-09-13 12:19:50.829364Z] Finished download-and-extract step (success) 05:19:50 INFO - [mozharness: 2017-09-13 12:19:50.829468Z] Running populate-webroot step. 05:19:50 INFO - Running pre-action listener: _resource_record_pre_action 05:19:50 INFO - Running main action method: populate_webroot 05:19:50 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:19:50 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 05:19:50 INFO - 'tests': ['tresize', 05:19:50 INFO - 'tcanvasmark']}, 05:19:50 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:19:50 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 05:19:50 INFO - 'tests': ['dromaeo_css', 05:19:50 INFO - 'kraken']}, 05:19:50 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 05:19:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:19:50 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 05:19:50 INFO - 'talos_options': ['--disable-stylo'], 05:19:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:19:50 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 05:19:50 INFO - 'tests': ['damp', 'tps']}, 05:19:50 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 05:19:50 INFO - 'talos_options': ['--disable-stylo'], 05:19:50 INFO - 'tests': ['damp', 'tps']}, 05:19:50 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:19:50 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 05:19:50 INFO - 'tests': ['dromaeo_dom']}, 05:19:50 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 05:19:50 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 05:19:50 INFO - 'tests': ['basic_compositor_video', 05:19:50 INFO - 'glvideo']}, 05:19:50 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 05:19:50 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 05:19:50 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 05:19:50 INFO - 'talos_options': ['--disable-stylo'], 05:19:50 INFO - 'tests': ['ts_paint_webext', 05:19:50 INFO - 'tp5o_webext']}, 05:19:50 INFO - 'other-e10s': {'tests': ['a11yr', 05:19:50 INFO - 'ts_paint', 05:19:50 INFO - 'tpaint', 05:19:50 INFO - 'sessionrestore', 05:19:50 INFO - 'sessionrestore_many_windows', 05:19:50 INFO - 'sessionrestore_no_auto_restore', 05:19:50 INFO - 'tabpaint']}, 05:19:50 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 05:19:50 INFO - 'tests': ['a11yr', 05:19:50 INFO - 'ts_paint', 05:19:50 INFO - 'tpaint', 05:19:50 INFO - 'sessionrestore', 05:19:50 INFO - 'sessionrestore_many_windows', 05:19:50 INFO - 'sessionrestore_no_auto_restore', 05:19:50 INFO - 'tabpaint']}, 05:19:50 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 05:19:50 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 05:19:50 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 05:19:50 INFO - 'tests': ['bloom_basic_singleton']}, 05:19:50 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 05:19:50 INFO - 'tests': ['bloom_basic']}, 05:19:50 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:19:50 INFO - 'tsvgr_opacity', 05:19:50 INFO - 'tart', 05:19:50 INFO - 'tscrollx', 05:19:50 INFO - 'tsvg_static']}, 05:19:50 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 05:19:50 INFO - 'tests': ['tsvgx', 05:19:50 INFO - 'tsvgr_opacity', 05:19:50 INFO - 'tart', 05:19:50 INFO - 'tscrollx', 05:19:50 INFO - 'tsvg_static']}, 05:19:50 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 05:19:50 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 05:19:50 INFO - 'talos_options': ['--disable-stylo'], 05:19:50 INFO - 'tests': ['tp5o']}, 05:19:50 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 05:19:50 INFO - 'talos_options': ['--mitmproxy', 05:19:50 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 05:19:50 INFO - '--firstNonBlankPaint'], 05:19:50 INFO - 'tests': ['tp6_google', 05:19:50 INFO - 'tp6_youtube', 05:19:50 INFO - 'tp6_amazon', 05:19:50 INFO - 'tp6_facebook']}, 05:19:50 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 05:19:50 INFO - 'talos_options': ['--disable-stylo', 05:19:50 INFO - '--mitmproxy', 05:19:50 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 05:19:50 INFO - '--firstNonBlankPaint'], 05:19:50 INFO - 'tests': ['tp6_google', 05:19:50 INFO - 'tp6_youtube', 05:19:50 INFO - 'tp6_amazon', 05:19:50 INFO - 'tp6_facebook']}, 05:19:50 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 05:19:50 INFO - 'talos_options': ['--stylo-threads=1', 05:19:50 INFO - '--mitmproxy', 05:19:50 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 05:19:50 INFO - '--firstNonBlankPaint'], 05:19:50 INFO - 'tests': ['tp6_google', 05:19:50 INFO - 'tp6_youtube', 05:19:50 INFO - 'tp6_amazon', 05:19:50 INFO - 'tp6_facebook']}, 05:19:50 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 05:19:50 INFO - 'talos_options': ['--xperf_path', 05:19:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:19:50 INFO - 'tests': ['tp5n']}, 05:19:50 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 05:19:50 INFO - 'talos_options': ['--disable-stylo', 05:19:50 INFO - '--xperf_path', 05:19:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:19:50 INFO - 'tests': ['tp5n']}}} 05:19:50 INFO - Running post-action listener: _resource_record_post_action 05:19:50 INFO - [mozharness: 2017-09-13 12:19:50.846230Z] Finished populate-webroot step (success) 05:19:50 INFO - [mozharness: 2017-09-13 12:19:50.846321Z] Running create-virtualenv step. 05:19:50 INFO - Running pre-action listener: _resource_record_pre_action 05:19:50 INFO - Running main action method: create_virtualenv 05:19:50 INFO - Creating virtualenv /builds/slave/test/build/venv 05:19:50 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 05:19:50 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 05:19:50 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 05:19:50 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:19:50 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:19:51 INFO - Installing distribute.............................................................................................................................................................................................done. 05:19:51 INFO - Installing pip...............done. 05:19:51 INFO - Return code: 0 05:19:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 05:19:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 05:19:51 INFO - Reading from file tmpfile_stdout 05:19:51 INFO - Output received: 05:19:51 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 05:19:51 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:19: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')]} 05:19:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:19: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')]} 05:19:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:19:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x151a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16e3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1886a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x188a090>, '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 0x188ad80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1884f90>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1505300237.672302-631552636', '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 05:19:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 05:19:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:19:51 INFO - Using env: {'DISPLAY': ':0', 05:19:51 INFO - 'HOME': '/home/cltbld', 05:19:51 INFO - 'LANG': 'en_US.UTF-8', 05:19:51 INFO - 'LANGUAGE': 'en_US:en', 05:19:51 INFO - 'LOGNAME': 'cltbld', 05:19:51 INFO - 'MAIL': '/var/mail/cltbld', 05:19:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:19:51 INFO - 'MOZ_NO_REMOTE': '1', 05:19:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:19:51 INFO - 'NO_EM_RESTART': '1', 05:19:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:19:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:19:51 INFO - 'PWD': '/builds/slave/test', 05:19:51 INFO - 'SHELL': '/bin/bash', 05:19:51 INFO - 'SHLVL': '1', 05:19:51 INFO - 'TERM': 'linux', 05:19:51 INFO - 'TMOUT': '86400', 05:19:51 INFO - 'USER': 'cltbld', 05:19:51 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1505300237.672302-631552636', 05:19:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:19:51 INFO - '_': '/tools/buildbot/bin/python'} 05:19:53 INFO - Ignoring indexes: http://pypi.python.org/simple/ 05:19:53 INFO - Downloading/unpacking pip>=1.5 05:19:53 INFO - Running setup.py egg_info for package pip 05:19:53 INFO - warning: no files found matching 'pip/cacert.pem' 05:19:53 INFO - warning: no files found matching '*.html' under directory 'docs' 05:19:53 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 05:19:53 INFO - no previously-included directories found matching 'docs/_build/_sources' 05:19:53 INFO - Installing collected packages: pip 05:19:53 INFO - Found existing installation: pip 1.1 05:19:53 INFO - Uninstalling pip: 05:19:53 INFO - Successfully uninstalled pip 05:19:53 INFO - Running setup.py install for pip 05:19:53 INFO - warning: no files found matching 'pip/cacert.pem' 05:19:53 INFO - warning: no files found matching '*.html' under directory 'docs' 05:19:53 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 05:19:53 INFO - no previously-included directories found matching 'docs/_build/_sources' 05:19:53 INFO - Installing pip script to /builds/slave/test/build/venv/bin 05:19:53 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 05:19:53 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 05:19:53 INFO - Successfully installed pip 05:19:53 INFO - Cleaning up... 05:19:53 INFO - Return code: 0 05:19:53 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:19:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:19:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:19:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:19:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:19:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x151a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16e3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1886a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x188a090>, '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 0x188ad80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1884f90>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1505300237.672302-631552636', '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 05:19:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 05:19:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 05:19:53 INFO - Using env: {'DISPLAY': ':0', 05:19:53 INFO - 'HOME': '/home/cltbld', 05:19:53 INFO - 'LANG': 'en_US.UTF-8', 05:19:53 INFO - 'LANGUAGE': 'en_US:en', 05:19:53 INFO - 'LOGNAME': 'cltbld', 05:19:53 INFO - 'MAIL': '/var/mail/cltbld', 05:19:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:19:53 INFO - 'MOZ_NO_REMOTE': '1', 05:19:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:19:53 INFO - 'NO_EM_RESTART': '1', 05:19:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:19:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:19:53 INFO - 'PWD': '/builds/slave/test', 05:19:53 INFO - 'SHELL': '/bin/bash', 05:19:53 INFO - 'SHLVL': '1', 05:19:53 INFO - 'TERM': 'linux', 05:19:53 INFO - 'TMOUT': '86400', 05:19:53 INFO - 'USER': 'cltbld', 05:19:53 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1505300237.672302-631552636', 05:19:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:19:53 INFO - '_': '/tools/buildbot/bin/python'} 05:19:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:19:53 INFO - Downloading/unpacking psutil>=3.1.1 05:19:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:19:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:19:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:19:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:19:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:19:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:19:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:19:54 INFO - Installing collected packages: psutil 05:19:54 INFO - Running setup.py install for psutil 05:19:54 INFO - building 'psutil._psutil_linux' extension 05:19:54 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 05:19:54 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 05:19:54 INFO - building 'psutil._psutil_posix' extension 05:19:54 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 05:19:54 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 05:19:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:19:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:19:54 INFO - Successfully installed psutil 05:19:54 INFO - Cleaning up... 05:19:55 INFO - Return code: 0 05:19:55 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:19: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')]} 05:19:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:19: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')]} 05:19:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:19: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x151a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16e3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1886a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x188a090>, '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 0x188ad80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1884f90>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1505300237.672302-631552636', '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 05:19: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 05:19: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 mozsystemmonitor==0.3 05:19:55 INFO - Using env: {'DISPLAY': ':0', 05:19:55 INFO - 'HOME': '/home/cltbld', 05:19:55 INFO - 'LANG': 'en_US.UTF-8', 05:19:55 INFO - 'LANGUAGE': 'en_US:en', 05:19:55 INFO - 'LOGNAME': 'cltbld', 05:19:55 INFO - 'MAIL': '/var/mail/cltbld', 05:19:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:19:55 INFO - 'MOZ_NO_REMOTE': '1', 05:19:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:19:55 INFO - 'NO_EM_RESTART': '1', 05:19:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:19:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:19:55 INFO - 'PWD': '/builds/slave/test', 05:19:55 INFO - 'SHELL': '/bin/bash', 05:19:55 INFO - 'SHLVL': '1', 05:19:55 INFO - 'TERM': 'linux', 05:19:55 INFO - 'TMOUT': '86400', 05:19:55 INFO - 'USER': 'cltbld', 05:19:55 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1505300237.672302-631552636', 05:19:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:19:55 INFO - '_': '/tools/buildbot/bin/python'} 05:19:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:19:55 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:19:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:19:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:19:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:19:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:19:56 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:19:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:19:56 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:19:56 INFO - Installing collected packages: mozsystemmonitor 05:19:56 INFO - Running setup.py install for mozsystemmonitor 05:19:56 INFO - Successfully installed mozsystemmonitor 05:19:56 INFO - Cleaning up... 05:19:56 INFO - Return code: 0 05:19:56 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:19:56 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')]} 05:19:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:19:56 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')]} 05:19:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:19:56 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 0x151a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16e3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1886a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x188a090>, '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 0x188ad80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1884f90>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1505300237.672302-631552636', '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 05:19:56 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 05:19:56 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 05:19:56 INFO - Using env: {'DISPLAY': ':0', 05:19:56 INFO - 'HOME': '/home/cltbld', 05:19:56 INFO - 'LANG': 'en_US.UTF-8', 05:19:56 INFO - 'LANGUAGE': 'en_US:en', 05:19:56 INFO - 'LOGNAME': 'cltbld', 05:19:56 INFO - 'MAIL': '/var/mail/cltbld', 05:19:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:19:56 INFO - 'MOZ_NO_REMOTE': '1', 05:19:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:19:56 INFO - 'NO_EM_RESTART': '1', 05:19:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:19:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:19:56 INFO - 'PWD': '/builds/slave/test', 05:19:56 INFO - 'SHELL': '/bin/bash', 05:19:56 INFO - 'SHLVL': '1', 05:19:56 INFO - 'TERM': 'linux', 05:19:56 INFO - 'TMOUT': '86400', 05:19:56 INFO - 'USER': 'cltbld', 05:19:56 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1505300237.672302-631552636', 05:19:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:19:56 INFO - '_': '/tools/buildbot/bin/python'} 05:19:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:19:56 INFO - Downloading/unpacking jsonschema==2.5.1 05:19: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 05:19: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 05:19: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 05:19: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 05:19:57 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:19:57 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:19:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:19:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:19:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:19:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:19:58 INFO - Downloading functools32-3.2.3-2.tar.gz 05:19:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:19:58 INFO - warning: no files found matching '*.txt' 05:19:58 INFO - no previously-included directories found matching 'build' 05:19:58 INFO - no previously-included directories found matching 'dist' 05:19:58 INFO - no previously-included directories found matching '.git*' 05:19:58 INFO - Installing collected packages: jsonschema, functools32 05:19:58 INFO - Running setup.py install for functools32 05:19:58 INFO - warning: no files found matching '*.txt' 05:19:58 INFO - no previously-included directories found matching 'build' 05:19:58 INFO - no previously-included directories found matching 'dist' 05:19:58 INFO - no previously-included directories found matching '.git*' 05:19:58 INFO - Successfully installed jsonschema functools32 05:19:58 INFO - Cleaning up... 05:19:58 INFO - Return code: 0 05:19:58 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:19:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:19:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:19:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:19:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:19:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x151a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16e3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1886a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x188a090>, '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 0x188ad80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1884f90>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1505300237.672302-631552636', '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 05:19:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 05:19:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 05:19:58 INFO - Using env: {'DISPLAY': ':0', 05:19:58 INFO - 'HOME': '/home/cltbld', 05:19:58 INFO - 'LANG': 'en_US.UTF-8', 05:19:58 INFO - 'LANGUAGE': 'en_US:en', 05:19:58 INFO - 'LOGNAME': 'cltbld', 05:19:58 INFO - 'MAIL': '/var/mail/cltbld', 05:19:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:19:58 INFO - 'MOZ_NO_REMOTE': '1', 05:19:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:19:58 INFO - 'NO_EM_RESTART': '1', 05:19:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:19:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:19:58 INFO - 'PWD': '/builds/slave/test', 05:19:58 INFO - 'SHELL': '/bin/bash', 05:19:58 INFO - 'SHLVL': '1', 05:19:58 INFO - 'TERM': 'linux', 05:19:58 INFO - 'TMOUT': '86400', 05:19:58 INFO - 'USER': 'cltbld', 05:19:58 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1505300237.672302-631552636', 05:19:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:19:58 INFO - '_': '/tools/buildbot/bin/python'} 05:19:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:19:58 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:19:58 INFO - Cleaning up... 05:19:58 INFO - Return code: 0 05:19:58 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:19:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:19:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:19:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:19:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:19:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x151a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16e3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1886a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x188a090>, '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 0x188ad80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1884f90>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1505300237.672302-631552636', '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 05:19:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:19:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:19:58 INFO - Using env: {'DISPLAY': ':0', 05:19:58 INFO - 'HOME': '/home/cltbld', 05:19:58 INFO - 'LANG': 'en_US.UTF-8', 05:19:58 INFO - 'LANGUAGE': 'en_US:en', 05:19:58 INFO - 'LOGNAME': 'cltbld', 05:19:58 INFO - 'MAIL': '/var/mail/cltbld', 05:19:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:19:58 INFO - 'MOZ_NO_REMOTE': '1', 05:19:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:19:58 INFO - 'NO_EM_RESTART': '1', 05:19:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:19:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:19:58 INFO - 'PWD': '/builds/slave/test', 05:19:58 INFO - 'SHELL': '/bin/bash', 05:19:58 INFO - 'SHLVL': '1', 05:19:58 INFO - 'TERM': 'linux', 05:19:58 INFO - 'TMOUT': '86400', 05:19:58 INFO - 'USER': 'cltbld', 05:19:58 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1505300237.672302-631552636', 05:19:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:19:58 INFO - '_': '/tools/buildbot/bin/python'} 05:19:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:19:58 INFO - Downloading/unpacking blobuploader==1.2.4 05:19: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 05:19: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 05:19: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 05:19: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 05:19:59 INFO - Downloading blobuploader-1.2.4.tar.gz 05:19:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:19:59 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:19:59 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 05:19:59 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 05:19:59 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 05:19:59 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 05:20:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:20:01 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:20: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 05:20: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 05:20: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 05:20: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 05:20:01 INFO - Downloading docopt-0.6.1.tar.gz 05:20:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:20:01 INFO - Installing collected packages: blobuploader, requests, docopt 05:20:01 INFO - Running setup.py install for blobuploader 05:20:01 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:20:01 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:20:01 INFO - Running setup.py install for requests 05:20:01 INFO - Running setup.py install for docopt 05:20:01 INFO - Successfully installed blobuploader requests docopt 05:20:01 INFO - Cleaning up... 05:20:01 INFO - Return code: 0 05:20:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:20: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')]} 05:20:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:20: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')]} 05:20:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:20:01 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 0x151a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16e3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1886a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x188a090>, '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 0x188ad80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1884f90>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1505300237.672302-631552636', '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 05:20:01 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 05:20:01 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 05:20:01 INFO - Using env: {'DISPLAY': ':0', 05:20:01 INFO - 'HOME': '/home/cltbld', 05:20:01 INFO - 'LANG': 'en_US.UTF-8', 05:20:01 INFO - 'LANGUAGE': 'en_US:en', 05:20:01 INFO - 'LOGNAME': 'cltbld', 05:20:01 INFO - 'MAIL': '/var/mail/cltbld', 05:20:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:20:01 INFO - 'MOZ_NO_REMOTE': '1', 05:20:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:20:01 INFO - 'NO_EM_RESTART': '1', 05:20:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:20:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:20:01 INFO - 'PWD': '/builds/slave/test', 05:20:01 INFO - 'SHELL': '/bin/bash', 05:20:01 INFO - 'SHLVL': '1', 05:20:01 INFO - 'TERM': 'linux', 05:20:01 INFO - 'TMOUT': '86400', 05:20:01 INFO - 'USER': 'cltbld', 05:20:01 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1505300237.672302-631552636', 05:20:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:20:01 INFO - '_': '/tools/buildbot/bin/python'} 05:20:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:20:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:20:02 INFO - Running setup.py (path:/tmp/pip-PtQ2Pu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:20:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:20:02 INFO - Running setup.py (path:/tmp/pip-Jac4Rh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:20:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:20:02 INFO - Running setup.py (path:/tmp/pip-llc3p1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:20:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:20:02 INFO - Running setup.py (path:/tmp/pip-H9_w1k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:20:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:20:02 INFO - Running setup.py (path:/tmp/pip-asMNrF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:20:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:20:02 INFO - Running setup.py (path:/tmp/pip-jraczH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:20:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:20:02 INFO - Running setup.py (path:/tmp/pip-dOyP5g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:20:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:20:02 INFO - Running setup.py (path:/tmp/pip-7ZN136-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:20:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:20:02 INFO - Running setup.py (path:/tmp/pip-wbc7v1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:20:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:20:02 INFO - Running setup.py (path:/tmp/pip-dbK7RY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:20:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:20:02 INFO - Running setup.py (path:/tmp/pip-5r8BlB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:20:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:20:02 INFO - Running setup.py (path:/tmp/pip-BSg2DD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:20:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:20:03 INFO - Running setup.py (path:/tmp/pip-kkiwL6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:20:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:20:03 INFO - Running setup.py (path:/tmp/pip-EUndzq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:20:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:20:03 INFO - Running setup.py (path:/tmp/pip-lqy9PC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:20:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:20:03 INFO - Running setup.py (path:/tmp/pip-z5J2MP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:20:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:20:03 INFO - Running setup.py (path:/tmp/pip-Ul2Cvr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:20:03 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:20:03 INFO - Running setup.py install for manifestparser 05:20:03 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:20:03 INFO - Running setup.py install for mozcrash 05:20:03 INFO - Running setup.py install for mozdebug 05:20:03 INFO - Running setup.py install for mozdevice 05:20:03 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:20:03 INFO - Running setup.py install for mozfile 05:20:03 INFO - Running setup.py install for mozhttpd 05:20:03 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:20:03 INFO - Running setup.py install for mozinfo 05:20:04 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:20:04 INFO - Running setup.py install for mozInstall 05:20:04 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:20:04 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:20:04 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:20:04 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:20:04 INFO - Running setup.py install for mozleak 05:20:04 INFO - Running setup.py install for mozlog 05:20:04 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:20:04 INFO - Running setup.py install for moznetwork 05:20:04 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:20:04 INFO - Running setup.py install for mozprocess 05:20:04 INFO - Running setup.py install for mozprofile 05:20:04 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:20:04 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:20:04 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:20:04 INFO - Running setup.py install for mozrunner 05:20:04 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:20:04 INFO - Running setup.py install for mozscreenshot 05:20:04 INFO - Running setup.py install for moztest 05:20:05 INFO - Running setup.py install for mozversion 05:20:05 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:20:05 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:20:05 INFO - Cleaning up... 05:20:05 INFO - Return code: 0 05:20:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:20:05 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')]} 05:20:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:20:05 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')]} 05:20:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:20:05 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 0x151a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16e3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1886a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x188a090>, '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 0x188ad80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1884f90>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1505300237.672302-631552636', '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 05:20:05 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 05:20:05 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 05:20:05 INFO - Using env: {'DISPLAY': ':0', 05:20:05 INFO - 'HOME': '/home/cltbld', 05:20:05 INFO - 'LANG': 'en_US.UTF-8', 05:20:05 INFO - 'LANGUAGE': 'en_US:en', 05:20:05 INFO - 'LOGNAME': 'cltbld', 05:20:05 INFO - 'MAIL': '/var/mail/cltbld', 05:20:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:20:05 INFO - 'MOZ_NO_REMOTE': '1', 05:20:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:20:05 INFO - 'NO_EM_RESTART': '1', 05:20:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:20:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:20:05 INFO - 'PWD': '/builds/slave/test', 05:20:05 INFO - 'SHELL': '/bin/bash', 05:20:05 INFO - 'SHLVL': '1', 05:20:05 INFO - 'TERM': 'linux', 05:20:05 INFO - 'TMOUT': '86400', 05:20:05 INFO - 'USER': 'cltbld', 05:20:05 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1505300237.672302-631552636', 05:20:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:20:05 INFO - '_': '/tools/buildbot/bin/python'} 05:20:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:20:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:20:05 INFO - Running setup.py (path:/tmp/pip-7xzPIQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:20:05 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)) 05:20:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:20:05 INFO - Running setup.py (path:/tmp/pip-jhNNL5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:20:05 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)) 05:20:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:20:05 INFO - Running setup.py (path:/tmp/pip-Xl88s7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:20:05 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)) 05:20:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:20:05 INFO - Running setup.py (path:/tmp/pip-DP80hD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:20:05 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)) 05:20:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:20:05 INFO - Running setup.py (path:/tmp/pip-WLtnM_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:20:05 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)) 05:20:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:20:05 INFO - Running setup.py (path:/tmp/pip-SsaEwx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:20:05 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)) 05:20:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:20:05 INFO - Running setup.py (path:/tmp/pip-udBKEY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:20:05 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)) 05:20:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:20:05 INFO - Running setup.py (path:/tmp/pip-YTkWvr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:20:05 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)) 05:20:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:20:05 INFO - Running setup.py (path:/tmp/pip-rn6BQl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:20:05 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)) 05:20:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:20:05 INFO - Running setup.py (path:/tmp/pip-ZXrBte-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:20:06 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)) 05:20:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:20:06 INFO - Running setup.py (path:/tmp/pip-G0J1v0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:20:06 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)) 05:20:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:20:06 INFO - Running setup.py (path:/tmp/pip-dxZhlF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:20:06 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)) 05:20:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:20:06 INFO - Running setup.py (path:/tmp/pip-Tc4sNO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:20:06 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)) 05:20:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:20:06 INFO - Running setup.py (path:/tmp/pip-fxNDJO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:20:06 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)) 05:20:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:20:06 INFO - Running setup.py (path:/tmp/pip-b25BO4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:20:06 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)) 05:20:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:20:06 INFO - Running setup.py (path:/tmp/pip-D9JKzi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:20:06 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)) 05:20:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:20:06 INFO - Running setup.py (path:/tmp/pip-rzDaoG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:20:06 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)) 05:20:06 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)) 05:20:06 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)) 05:20:06 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)) 05:20:06 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)) 05:20:06 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)) 05:20:06 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)) 05:20:06 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:20:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:20:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:20:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:20:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:20:07 INFO - Downloading blessings-1.6.tar.gz 05:20:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:20:07 INFO - Installing collected packages: blessings 05:20:07 INFO - Running setup.py install for blessings 05:20:07 INFO - Successfully installed blessings 05:20:07 INFO - Cleaning up... 05:20:08 INFO - Return code: 0 05:20:08 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:20:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:20:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:20:08 INFO - Reading from file tmpfile_stdout 05:20:08 INFO - Current package versions: 05:20:08 INFO - argparse == 1.2.1 05:20:08 INFO - blessings == 1.6 05:20:08 INFO - blobuploader == 1.2.4 05:20:08 INFO - docopt == 0.6.1 05:20:08 INFO - functools32 == 3.2.3-2 05:20:08 INFO - jsonschema == 2.5.1 05:20:08 INFO - manifestparser == 1.1 05:20:08 INFO - mozInstall == 1.13 05:20:08 INFO - mozcrash == 1.0 05:20:08 INFO - mozdebug == 0.1 05:20:08 INFO - mozdevice == 0.51 05:20:08 INFO - mozfile == 1.2 05:20:08 INFO - mozhttpd == 0.7 05:20:08 INFO - mozinfo == 0.10 05:20:08 INFO - mozleak == 0.1 05:20:08 INFO - mozlog == 3.5 05:20:08 INFO - moznetwork == 0.27 05:20:08 INFO - mozprocess == 0.25 05:20:08 INFO - mozprofile == 0.28 05:20:08 INFO - mozrunner == 6.13 05:20:08 INFO - mozscreenshot == 0.1 05:20:08 INFO - mozsystemmonitor == 0.3 05:20:08 INFO - moztest == 0.8 05:20:08 INFO - mozversion == 1.4 05:20:08 INFO - psutil == 3.1.1 05:20:08 INFO - requests == 1.2.3 05:20:08 INFO - wsgiref == 0.1.2 05:20:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:20:08 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')]} 05:20:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:20:08 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')]} 05:20:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:20:08 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 0x151a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16e3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1886a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x188a090>, '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 0x188ad80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1884f90>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1505300237.672302-631552636', '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 05:20:08 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 05:20:08 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 05:20:08 INFO - Using env: {'DISPLAY': ':0', 05:20:08 INFO - 'HOME': '/home/cltbld', 05:20:08 INFO - 'LANG': 'en_US.UTF-8', 05:20:08 INFO - 'LANGUAGE': 'en_US:en', 05:20:08 INFO - 'LOGNAME': 'cltbld', 05:20:08 INFO - 'MAIL': '/var/mail/cltbld', 05:20:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:20:08 INFO - 'MOZ_NO_REMOTE': '1', 05:20:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:20:08 INFO - 'NO_EM_RESTART': '1', 05:20:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:20:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:20:08 INFO - 'PWD': '/builds/slave/test', 05:20:08 INFO - 'SHELL': '/bin/bash', 05:20:08 INFO - 'SHLVL': '1', 05:20:08 INFO - 'TERM': 'linux', 05:20:08 INFO - 'TMOUT': '86400', 05:20:08 INFO - 'USER': 'cltbld', 05:20:08 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1505300237.672302-631552636', 05:20:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:20:08 INFO - '_': '/tools/buildbot/bin/python'} 05:20:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:20:08 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)) 05:20:08 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)) 05:20:08 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)) 05:20:08 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)) 05:20:08 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)) 05:20:08 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)) 05:20:08 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)) 05:20:08 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)) 05:20:08 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)) 05:20:08 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 05:20:08 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 05:20:08 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 05:20:08 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 05:20:08 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 05:20:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 05:20:09 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)) 05:20:09 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)) 05:20:09 INFO - Installing collected packages: simplejson 05:20:09 INFO - Running setup.py install for simplejson 05:20:09 INFO - building 'simplejson._speedups' extension 05:20:09 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 05:20:10 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 05:20:10 INFO - Successfully installed simplejson 05:20:10 INFO - Cleaning up... 05:20:10 INFO - Return code: 0 05:20:10 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:20: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')]} 05:20:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:20: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')]} 05:20:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:20:10 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 0x151a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16e3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1886a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x188a090>, '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 0x188ad80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1884f90>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1505300237.672302-631552636', '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 05:20:10 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 05:20:10 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 05:20:10 INFO - Using env: {'DISPLAY': ':0', 05:20:10 INFO - 'HOME': '/home/cltbld', 05:20:10 INFO - 'LANG': 'en_US.UTF-8', 05:20:10 INFO - 'LANGUAGE': 'en_US:en', 05:20:10 INFO - 'LOGNAME': 'cltbld', 05:20:10 INFO - 'MAIL': '/var/mail/cltbld', 05:20:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:20:10 INFO - 'MOZ_NO_REMOTE': '1', 05:20:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:20:10 INFO - 'NO_EM_RESTART': '1', 05:20:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:20:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:20:10 INFO - 'PWD': '/builds/slave/test', 05:20:10 INFO - 'SHELL': '/bin/bash', 05:20:10 INFO - 'SHLVL': '1', 05:20:10 INFO - 'TERM': 'linux', 05:20:10 INFO - 'TMOUT': '86400', 05:20:10 INFO - 'USER': 'cltbld', 05:20:10 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1505300237.672302-631552636', 05:20:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:20:10 INFO - '_': '/tools/buildbot/bin/python'} 05:20:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:20:10 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:20:10 INFO - Cleaning up... 05:20:10 INFO - Return code: 0 05:20:10 INFO - Running post-action listener: _resource_record_post_action 05:20:10 INFO - Running post-action listener: _start_resource_monitoring 05:20:10 INFO - Starting resource monitoring. 05:20:10 INFO - [mozharness: 2017-09-13 12:20:10.961424Z] Finished create-virtualenv step (success) 05:20:10 INFO - [mozharness: 2017-09-13 12:20:10.961888Z] Running install step. 05:20:10 INFO - Running pre-action listener: _resource_record_pre_action 05:20:10 INFO - Running main action method: install 05:20:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:20:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:20:11 INFO - Reading from file tmpfile_stdout 05:20:11 INFO - Detecting whether we're running mozinstall >=1.0... 05:20:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:20:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:20:11 INFO - Reading from file tmpfile_stdout 05:20:11 INFO - Output received: 05:20:11 INFO - Usage: mozinstall [options] installer 05:20:11 INFO - Options: 05:20:11 INFO - -h, --help show this help message and exit 05:20:11 INFO - -d DEST, --destination=DEST 05:20:11 INFO - Directory to install application into. [default: 05:20:11 INFO - "/builds/slave/test"] 05:20:11 INFO - --app=APP Application being installed. [default: firefox] 05:20:11 INFO - mkdir: /builds/slave/test/build/application 05:20:11 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'] 05:20:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 05:20:29 INFO - Reading from file tmpfile_stdout 05:20:29 INFO - Output received: 05:20:29 INFO - /builds/slave/test/build/application/firefox/firefox 05:20:29 INFO - Running post-action listener: _resource_record_post_action 05:20:29 INFO - [mozharness: 2017-09-13 12:20:29.088203Z] Finished install step (success) 05:20:29 INFO - [mozharness: 2017-09-13 12:20:29.088454Z] Running setup-mitmproxy step. 05:20:29 INFO - Running pre-action listener: _resource_record_pre_action 05:20:29 INFO - Running main action method: setup_mitmproxy 05:20:29 INFO - Skipping: mitmproxy is not required 05:20:29 INFO - Running post-action listener: _resource_record_post_action 05:20:29 INFO - [mozharness: 2017-09-13 12:20:29.089679Z] Finished setup-mitmproxy step (success) 05:20:29 INFO - [mozharness: 2017-09-13 12:20:29.089901Z] Running run-tests step. 05:20:29 INFO - Running pre-action listener: _resource_record_pre_action 05:20:29 INFO - Running pre-action listener: _set_gcov_prefix 05:20:29 INFO - Running main action method: run_tests 05:20:29 WARNING - Try message not found. 05:20:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:20:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:20:29 INFO - Python 2.7.3 05:20:29 INFO - Return code: 0 05:20:29 INFO - grabbing minidump binary from tooltool 05:20:29 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')]} 05:20:29 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 0x188a090>, '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 0x188ad80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1884f90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:20:29 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 05:20:29 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 05:20:29 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 05:20:29 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:20:29 INFO - Return code: 0 05:20:29 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:20:29 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:20:29 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:20:29 INFO - ENV: RUST_BACKTRACE is now full 05:20:29 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:20:29 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:20:29 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/DkoRCDt5TmCGOf_xf-Pg9A/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-062', '--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 05:20:29 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/DkoRCDt5TmCGOf_xf-Pg9A/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-062 --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 05:20:29 INFO - Using env: {'DISPLAY': ':0', 05:20:29 INFO - 'HOME': '/home/cltbld', 05:20:29 INFO - 'LANG': 'en_US.UTF-8', 05:20:29 INFO - 'LANGUAGE': 'en_US:en', 05:20:29 INFO - 'LOGNAME': 'cltbld', 05:20:29 INFO - 'MAIL': '/var/mail/cltbld', 05:20:29 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:20:29 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:20:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:20:29 INFO - 'MOZ_NO_REMOTE': '1', 05:20:29 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:20:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:20:29 INFO - 'NO_EM_RESTART': '1', 05:20:29 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:20:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:20:29 INFO - 'PWD': '/builds/slave/test', 05:20:29 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:20:29 INFO - 'RUST_BACKTRACE': 'full', 05:20:29 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 05:20:29 INFO - 'SHELL': '/bin/bash', 05:20:29 INFO - 'SHLVL': '1', 05:20:29 INFO - 'TERM': 'linux', 05:20:29 INFO - 'TMOUT': '86400', 05:20:29 INFO - 'USER': 'cltbld', 05:20:29 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1505300237.672302-631552636', 05:20:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:20:29 INFO - '_': '/tools/buildbot/bin/python'} 05:20:29 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/DkoRCDt5TmCGOf_xf-Pg9A/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-062', '--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 05:20:29 INFO - mozversion application_buildid: 20170913113324 05:20:29 INFO - mozversion application_changeset: 1888ec2f277f6bb26271b8808e08914a21db9efe 05:20:29 INFO - mozversion application_display_name: Nightly 05:20:29 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:20:29 INFO - mozversion application_name: Firefox 05:20:29 INFO - mozversion application_remotingname: firefox 05:20:29 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:20:29 INFO - mozversion application_vendor: Mozilla 05:20:29 INFO - mozversion application_version: 57.0a1 05:20:29 INFO - mozversion platform_buildid: 20170913113324 05:20:29 INFO - mozversion platform_changeset: 1888ec2f277f6bb26271b8808e08914a21db9efe 05:20:29 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:20:29 INFO - mozversion platform_version: 57.0a1 05:20:29 INFO - using testdate: 1505305229 05:20:29 INFO - actual date: 1505305229 05:20:29 INFO - starting webserver on 'localhost:48248' 05:20:29 INFO - SUITE-START | Running 2 tests 05:20:29 INFO - TEST-START | dromaeo_css 05:20:29 INFO - Initialising browser for dromaeo_css test... 05:20:29 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:48248/getInfo.html -profile /tmp/tmpy3GNwp/profile 05:20:29 INFO - TEST-INFO | started process 975 (/builds/slave/test/build/application/firefox/firefox http://localhost:48248/getInfo.html) 05:20:34 INFO - TEST-INFO | 975: exit 0 05:20:34 INFO - Browser initialized. 05:20:34 INFO - Running cycle 1/1 for dromaeo_css test... 05:20:34 INFO - Using env: {'DISPLAY': ':0', 05:20:34 INFO - 'HOME': '/home/cltbld', 05:20:34 INFO - 'JSGC_DISABLE_POISONING': '1', 05:20:34 INFO - 'LANG': 'en_US.UTF-8', 05:20:34 INFO - 'LANGUAGE': 'en_US:en', 05:20:34 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 05:20:34 INFO - 'LOGNAME': 'cltbld', 05:20:34 INFO - 'MAIL': '/var/mail/cltbld', 05:20:34 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:20:34 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:20:34 INFO - 'MOZ_CRASHREPORTER': '1', 05:20:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:20:34 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 05:20:34 INFO - 'MOZ_NO_REMOTE': '1', 05:20:34 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:20:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:20:34 INFO - 'NO_EM_RESTART': '1', 05:20:34 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:20:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:20:34 INFO - 'PWD': '/builds/slave/test', 05:20:34 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:20:34 INFO - 'RUST_BACKTRACE': 'full', 05:20:34 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 05:20:34 INFO - 'SHELL': '/bin/bash', 05:20:34 INFO - 'SHLVL': '1', 05:20:34 INFO - 'STYLO_FORCE_DISABLED': '1', 05:20:34 INFO - 'TERM': 'linux', 05:20:34 INFO - 'TMOUT': '86400', 05:20:34 INFO - 'USER': 'cltbld', 05:20:34 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1505300237.672302-631552636', 05:20:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:20:34 INFO - '_': '/tools/buildbot/bin/python'} 05:20:34 INFO - TEST-INFO | started process 1175 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpy3GNwp/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 05:20:35 INFO - PID 1175 | 05:20:35 INFO - PID 1175 | (/builds/slave/test/build/application/firefox/firefox:1224): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 05:20:35 INFO - PID 1175 | 05:20:45 INFO - PID 1175 | RSS: Main: 173490176 05:20:45 INFO - PID 1175 | 05:23:42 INFO - PID 1175 | Cycle 1(1): loaded http://localhost:48248/tests/dromaeo/cssquery-dojo.html (next: http://localhost:48248/tests/dromaeo/cssquery-ext.html) 05:23:43 INFO - PID 1175 | RSS: Main: 175882240 05:23:43 INFO - PID 1175 | 05:26:45 INFO - PID 1175 | Cycle 1(1): loaded http://localhost:48248/tests/dromaeo/cssquery-ext.html (next: http://localhost:48248/tests/dromaeo/cssquery-jquery.html) 05:26:46 INFO - PID 1175 | RSS: Main: 171372544 05:26:46 INFO - PID 1175 | 05:29:48 INFO - PID 1175 | Cycle 1(1): loaded http://localhost:48248/tests/dromaeo/cssquery-jquery.html (next: http://localhost:48248/tests/dromaeo/cssquery-mootools.html) 05:29:48 INFO - PID 1175 | RSS: Main: 175075328 05:29:48 INFO - PID 1175 | 05:32:50 INFO - PID 1175 | Cycle 1(1): loaded http://localhost:48248/tests/dromaeo/cssquery-mootools.html (next: http://localhost:48248/tests/dromaeo/cssquery-prototype.html) 05:32:51 INFO - PID 1175 | RSS: Main: 173682688 05:32:51 INFO - PID 1175 | 05:35:54 INFO - PID 1175 | Cycle 1(1): loaded http://localhost:48248/tests/dromaeo/cssquery-prototype.html (next: http://localhost:48248/tests/dromaeo/cssquery-yui.html) 05:35:54 INFO - PID 1175 | RSS: Main: 174694400 05:35:54 INFO - PID 1175 | 05:38:56 INFO - PID 1175 | Cycle 1(1): loaded http://localhost:48248/tests/dromaeo/cssquery-yui.html (next: http://localhost:48248/tests/dromaeo/cssquery-dojo.html) 05:38:56 INFO - PID 1175 | RSS: Main: 178184192 05:38:56 INFO - PID 1175 | 05:38:56 INFO - PID 1175 | __start_tp_report 05:38:56 INFO - PID 1175 | _x_x_mozilla_page_load 05:38:56 INFO - PID 1175 | _x_x_mozilla_page_load_details 05:38:56 INFO - PID 1175 | |i|pagename|runs| 05:38:56 INFO - PID 1175 | |0;dojo.html;3111.9688803111967;3145.24514116612;3177.046885934219;3178.952315715263;3185.347003864208;6243.282022567406;6382.648954307511;6394.808155755329;6420.678966051696;6468.932626116697;6314.1475900753385;6353.396427339407;6356.110144579762;6394.369435793866;6396.072569477423;5816.418358164171;5851.678157701314;5927.585069045169;5936.88126237475;5946.554008449362;5849.327327357345;5889.528837692996;5892.292924849003;5927.644341339534;5983.910241346383;231.7422149099679;5621.943780562183;5682.744276507547;5714.885702285952;5867.706614669292;5806.83863227352;5828.125781132864;5848.356680765112;5857.121431785266;5892.764289428418;5744.224529688522;5785.913211301834;5826.2134611827705;5834.883302333972;5836.708164591753;6280.623162610213;6301.558890877641;6365.427111559982;6385.712642931079;6401.807945761635;6586.637734924578;6743.4942379321255;6821.761238356634;6877.6217308048535;6886.621235832027;6783.457323414115;6861.588304701734;6969.372756451944;6974.0236366908675;6976.651167441659;6237.313895471494;6407.519436042316;6419.743210271584;6485.221773387177;6490.026496025586;7008.229094799619;7026.789196324118;7142.750003749844;7144.249853765384;7144.714211431485;6647.0029495576055;6653.234877989094;6747.797566073025;6747.932520674829;6749.0551322814845;6698.966505167443;6768.526203165829;6804.693788779517;6855.143107111611;6861.622610756356;6803.421709154678;6804.08144900442;6817.181938167451;6828.897566536506;6831.385175334144;6830.59016459014;6903.75836845708;6908.758193463204;6955.130608673916;6958.408535274457;5293.841184764463;5310.814121505806;5378.139497680352;5409.810656626999;5429.239906413105;4509.255972764523;4575.519570445122;4580.977095114503;4675.018246168343;4684.578387945101;5806.4193580641595;5874.588778785529;5885.264341957255;5912.881742365129;5919.55603329752;6609.867802644017;6680;6767.966160169266;6773.72905083801;6816.147981502312;5655.1799989001365;5728.226689396962;5786.855328616818;5814.505767009767;5835.679037652885;5801.9129713054335;5807.535397168216;5912.674802885796;5918.4377484139795;5932.940670593325;6421.903671444932;6438.163038805019;6515.641639709766;6519.956806910872;6587.901181482282;6668.766593169215;6669.799906002828;6734.259231484631;6773.288804675438;6787.321267873173;6414.134091897534;6417.903731443938;6487.513436492188;6531.11829902957;6537.5096867734155;6632.772937006669;6728.158980127484;6731.596104233761;6732.5525012122625;6759.932400675931;6764.0868482754195;6784.694688739118;6851.246362900177;6862.245153033262;6880.277570854988;6452.870942581216;6544.051112588743;6549;6557.770478033246;6557.901631475436;6406.583572067801;6498.577592456475;6515.771947981798;6571.507136964842;6582.210134783665;6429.2284925807335;6452.774152904626;6483.643399612878;6486.902696459462;6512.05575191604;6579.144711187515;6624.900626490703;6652;6689.866202675822;6752.054712340178;6495.123158373559;6495.610263384212;6529;6571.817072926728;6576.868462630816 05:38:56 INFO - PID 1175 | |1;ext.html;867.7526904832124;878.1262643669546;897.3404547657467;898.3621628643663;898.8247291778104;38996.41505377418;42502.362464563055;42582.36126458102;42636.14727705444;42833.78583107084;39233.41149882754;39625.8018709906;39662;39721;39763.80118099406;7154.96422517888;7294.307040831112;7682.731104411347;7906.881396779053;7911.604419779017;7866.331361834251;7964.960175199116;7965.203479652047;7969.641366138538;7975.162607926171;7925.128235894047;7966.601669916481;7967.402444816662;7967.880481792778;7981.0422749270165;7922.207779222089;7929.088154862207;7940.2059794020715;7965.800854978614;7979.840403191962;7825.178356272566;7875.369970402354;7879.487833290817;7879.566623835687;7882.960585197037;38670.80664596687;38924;38956.02609934746;38964.22071558581;38996;3522.066652337107;3523.1896663767475;3527.7177825773874;3549.9290014199573;3552.928941421183;31546.211344716336;31558.526622100686;31565.526517102262;31681.20796980094;31699.36601267985;5013.548780609763;5190.429052804188;5259.76331065103;5272;5280.551153151987;180384;180460;181940;182082.99999999866;182532;42673.57326426758;43520.347194792106;49084;49183;49271;50201.49798502041;50938.74530627397;50989.49010509922;51142.48857511377;51260;15264.618384540476;15295.923520382326;15304.617384565476;15319;15452.227388630523;12307.630771076882;12325.753484930252;12332.136750427384;12337.814932776015;12379.823916727897;13933.651658708613;14047.508337208148;14095.929520352332;14126.081804682663;14171.220582868042;5758.2514273144225;5794.391588883191;5830.912536311958;5872.442117998783;5889.705514724246;1009.6970908727352;1026.3636545341787;1040;1040.8386700061503;1041.375174895057;23032.7696723034;23783.52432951366;23803.285901422638;24028.51942961131;24107.27678169658;1124.24675467437;1132.0717012050204;1135.4663308245113;1144.4277861069465;1151.5681619392728;12160.022377957705;12359.269702241694;12450.501979920882;12486.937565312297;12657.493700251887;220419;221015;222187;222618;222708;52622;52752;53216.46783532193;53267.46732532625;53755.46244537583;1456.6139972907188;1470.7426200414884;1484.139199264424;1500.2423775993054;1501.2718831366778;22755.88622056879;22898.42753931165;23112.4221894454;23134.305970820904;23170.536589268457;37594.624053759115;37778.811105944296;37793.24413511659;38110;38239;179068;181007;183386;183823;184309;34323.31353372869;35801.46297805483;36979.260414792094;36997;37117;44413.77793111014;45156.32265516085;45844.08311833678;45905.540944590124;46309.76845115753;33173.83413082919;33198.668013319555;33451.330973380886;33812.830935845166;34085.65914340825;33689;33907.4913876297;33942;33958;34464.48303275503;37934.62065379421;38073.4288985671;38124;38581;38588.42117368298;32630.184245394055;33127.33745325128;33131.17172070718;33191.50212746859;33516.832415837765;23939.640905386084;24799.752002480465;25000.249992500256;25261.74738252594;25640.871795641648 05:38:56 INFO - PID 1175 | |2;jquery.html;564.3791828988113;569.2059576890235;570.2700543304571;577.8064348443271;588.6085752974273;21921.342359729195;22648.88675556622;22662.54674906503;22686.205982790605;22694;24190.274291771275;24383.02467901282;24695.876520617418;24735.75264247357;25605.87197064012;6486.091947127394;6627.46980241582;6664.333566643345;6672.633005184713;6679.899801502981;6372.267189273247;6586.80239592813;6673.766418175364;6674.699638516278;6677.799666010027;6652;6660.567063140905;6667.199936007686;6684.766033188839;6685.398314151726;6216.316205217445;6444.291127975919;6451.1936007999;6626.237982631987;6656.0348749431305;6028.698565071729;6036.728347224342;6058.96970515149;6061.909071363933;6062.575619706622;29297.853510732522;29838.40323193524;29842.70157298421;29848.701512985026;29854.552181717292;2062.4019034479984;2089.3314139475374;2094.1623350659706;2095.4551816527814;2097.528056187361;19365.4190374289;19609.019549022636;19916.302929397545;20171.294004709765;20176.798232017787;2409.6506006629115;2439.292605144506;2462.409021834747;2462.901483940658;2506.9247922562354;118922;123454;134612;140836;140950.59049409477;14781.92609036948;14864.777028344584;14957.194476513161;15032.699346013018;15101.620530046383;22998.19506317271;23089.538209236056;23118.1908633197;23118.1908633197;23191.652125218134;10199.490025498695;10243.7439064024;10313.226508011929;10381.9480902595;10391.948040259751;9580.233581313478;9599.952000239955;9632.181264592587;9688.90311096894;9723.805523889625;9259.166674999282;9419.764505887408;9431.821022372204;9448.779536808845;9477.952610236905;2658.8803503842373;2659.7739192168883;2710.52565800988;2734.931626709348;2750.2436829871544;940.6519587752575;962.5812771444444;964.7346979580531;968.1431932739576;970.9659212938199;18768.62462750737;18915.90542047281;18973.335933242546;19102.426927192206;19538.609227815363;982.7395740128871;1008.3294609085023;1017.7685001148693;1023.1967905194387;1038.1020417338948;10323.174146068297;10603.84094238587;10780.191485638608;10892.836607450894;10928.726781830517;411971;421471;434061;434391;436917;108723;110132;113335.4333228345;115166;115927.42036289764;1005.8792944846518;1075.2526993739275;1076.5155679944057;1107.0866535108407;1133.699569614053;20560.38318850437;20566.897165514078;20611.17555297831;20682.379528614165;20921.686174707087;56083.15875261956;56124.719376402856;56401.71799140978;56634;58559.12161317498;68540.31459685539;69436.305636945;69465.65267173632;70064.64967675129;70144.29855701582;14084;14400.135991840523;14461.349239284047;14475.85524144745;14514.564563063124;23120.306390808302;23273.185438509572;23327;23337.88331058334;23563.293101206993;18564.535886602942;18754.249830007193;18826.623467530848;18850.586206034877;18940.43178704641;16464.83535164681;16554.255058522634;16565.58586035359;17082;17368;18166.90916545409;18312.359067432575;18318.450446486626;18395;18597.535061623028;13957.720845582828;14007.789883151558;14030.57908262713;14050.578482645536;14108.435662573382;17965.910170449064;18056;18277.634447311244;18451.630967380308;18581.81418185855 05:38:56 INFO - PID 1175 | |3;mootools.html;1257.647858599592;1343.5297645823969;1369.1100784490084;1371.4856928651755;1376.9931150344241;14654.120752754829;15295.235238238085;15344.386224551004;15376.61558461039;15381.846181538182;14919.403223871032;15004.474843380483;15054.698906021873;15064.32210550525;15078.396864125421;2515.3837309859064;2549.31168584483;2558.4883023395396;2561.3596600849787;2565.0381107084845;2370.8933098010543;2479.7396273391214;2482.8758562071916;2502.78726308264;2509.5357358888573;2242.955140897181;2348.201611452106;2461.655368248447;2465.2480993297036;2465.3466831289634;2494.102123235652;2501.849889006656;2525.217182673377;2534.6831646044243;2535.1000394859834;2393.389685630171;2490.6264060390904;2515.6478093066985;2521.042004038472;2527.4186937004592;14837.703245935129;15011.399544018226;15058.32237549313;15062.096274223471;15066.548003559801;7411.740589079411;7680;7705.807354816175;7715.151333353327;7725.613719314012;5102.668326558799;5231.305877473066;5264.684118952837;5338.519533241988;5344.759485823147;1832.4777438430117;1850.5188650950715;1862.4505770797648;1885.5286178455385;1888.1314595286185;26039;26082.34794130143;26133.346666333302;26301;26401.603975940376;6205.844853878689;6405.903911441239;6407.13503677007;6448.709808058648;6536.24833144185;17126.571835704206;17202.1398930053;17524.299028038735;17542.824571754376;17598.82401175972;7416.25837416254;7650.4644674872225;7685.923140768521;7692.615369231516;7722.3436007938835;7093.503454758117;7119.3948514375825;7177;7413.147488038837;7417.147028091731;4966.801327946841;5163.251328557338;5169.948300517022;5174.611904107207;5196.246544251062;1484.406237504985;1492.4627134231669;1497.8202615686187;1505.631120375493;1507.186119495482;884.2307192742355;888.9377743558018;896.2964073202505;908.6910450446879;909.7088931541975;7498.887516687145;7528.322450979438;7532.284432978859;7616.314531692175;7633.084029916335;703.268600655323;728.5155371677774;731.5171986488998;732.5641243460133;733.6441825714525;4600.5169457207185;4607.516210797818;5370.812021579226;5425.9186112208345;5616.045272303718;20311.187552497733;21647.567048659253;21695.783042169376;21698.56602867934;21712;21122.683159752614;21455.356339309845;21665;21683.45791355197;21931.67102493464;11502.654920352403;11568;11600.88399116015;11616.709582260342;11654.067674586013;8178.591070446335;8494.660213591387;8495.447795893248;8541.487510749375;8567.74296771098;18045;18538.536536586154;18789.812101878808;18944.905275473535;19136.521586960436;18555.90722046381;18769.718454222926;18793.624127517647;18833.24667013359;18944;10663.840042399526;10769.9461502692;10831.620893268699;10892.509837057192;10897.618583349546;13648.181109133484;13705.177689338672;13773.724525509233;13851.376688049264;13862.098963567336;11020.173486988348;11112.277701949348;11351.659450216506;11545.076393888301;11633.941830290794;10758.515866785858;10852.565897364333;11001.064909482784;11023.669289921316;11072.280301780358;10026.749331266778;10113.64602238918;10122.645707400206;10205.846912296172;10207;7403.259674032553;7446.664900079618;7458.179600244077;7506.512076714996;7544;7454;7491.70033198666;7586.089669239726;7594.088709354692;7661.540307581563 05:38:56 INFO - PID 1175 | |4;prototype.html;505.80273693259613;506.47832732285747;519.3352508788751;526.9868253293668;530.8991291654588;6229.906551401721;6237.251529816417;6263.561550691454;6271.905921411182;6278.2779980302275;6053.667048312341;6060.969695151518;6169.352218017111;6179.536534759888;6180.783672571461;4901.289313049623;5039.7732102055315;5081.856582268978;5112.130937740574;5131.050755610206;4991.550760431561;5073.974630126862;5082.491750824906;5092.414372347172;5094;4924.778384972685;4927.359443272369;4968.627352948525;4987.401511818587;5007.724575148365;4933.284673722308;4973.477784832613;5014.24786282057;5014.398272207359;5017.297578338999;4489.685721999462;4509.323601459774;4517.299818528133;4542.38677778499;4551.749653769041;5965.940340596625;5996.8500787480225;6013.458788709037;6130.570860039799;6142.170806941051;5700.37295897451;5700.7719691212305;5713.8285851424525;5742.913856292159;5773.9422605773825;6528.81284769598;6587.835304117388;6593.241777195636;6612.86774264512;6628.8674226515195;4854.563089321942;4859.951400485986;4869.82955596556;4875.293082503017;4921.335619691332;6500.284968653492;6536.934630653727;6693.799186024378;6812.557183783038;6929.44564434844;4927.482614325444;4998.275250088716;4999.42506611737;5020.949790502122;5028.522290382408;5058.898822023539;5074.568661663726;5076.340075790124;5086.9745651271505;5098.337216161875;5643.633163844419;5661.688607126565;5677.432256774372;5678.501459357952;5746.4253574643035;6526.902096468557;6565.179352580927;6586.7035983380865;6604.735810567524;6626.171728533934;1702.838230368113;1742.7821522309712;1761.5772214668386;1762.6739053275185;1762.9559261018578;1165.1145129701488;1193.5524178433088;1209.5464200924653;1228.263042174688;1228.3796682675193;5612.20409468966;5622.803201887914;5631.436856314336;5685.971570142123;5697.772089116389;6465.515086368541;6549.443297319781;6577.7635603894905;6632.933670663231;6667;5546.556275498031;5619.522340601095;5646.774129034792;5679.399686254147;5706.914396284059;3440.36353274645;3445.6898879101;3455.6825447570113;3484.4773284007097;3517.3317069756663;6291.811245662638;6314.210723659543;6392.776252831221;6422.743090276336;6431.13179720741;6700.363465470772;6764.458843292525;6771.221309549366;6780.762673306411;6836.4530837532875;5914.615549989237;6346.809595712136;6365.2679941806355;6377;6433.871322573522;6404.88638749221;6483.272118531957;6604.664644354571;6610.504212184202;6617.172853393326;6469.870602587827;6567.179102612174;6592.637404942774;6662.400383965466;6702.698378572878;6390.616563006234;6451.612903225821;6461.57999730016;6497.220333560003;6509.218893732783;5420.4850539198715;5494.423085575957;5514.09017512106;5528.585356098389;5581.190727344593;6487.15116191883;6664.300248473841;6674;6898.896516552155;6919.446444284546;6495.285518593046;6527.934720652733;6533.575317604531;6543.476521878143;6641.402273795382;6461.8061458156335;6477.931141361622;6523.64119973406;6561.376669216417;6578.703958321791;6483.319251478527;6499.415052645285;6501.382368674968;6516.924707423222;6523.629168457051;6451;6470.158879345655;6545.429097016777;6551.967240163959;6587.242467116152;6198.318184999736;6324.557280990287;6398.424141827258;6420.454261387647;6485.156929599122 05:38:56 INFO - PID 1175 | |5;yui.html;890.5814267294373;894.9373543851931;920.236203950721;922.0641049334922;931.2782593490044;17193.312267509285;17527.73708394372;17624.82375176248;17631.38290159843;17632.11839408031;17556.648867022654;17903.64192716145;17910.910445447786;17977.640447191083;17994.730079048826;967.9564419601135;968.6851773173712;971.9562619682131;972.533184071646;972.7519482531944;953.909378609031;955.2262667239523;956.5599824080931;956.8325543029977;973.9269554783384;995.6664517386648;1011.7420057885229;1011.9392836429838;1018.5416562546847;1031.417249254169;994.3288280410694;999.0309399882175;1010.5957616953204;1011.4487604255662;1027.3014350241833;725.5284065357507;741.1735914455397;744.0699126092385;748.7005197920821;749.6401727170934;18817.717734233996;18854.905725471286;18933.905330473397;18974.14616342254;18991.33530326446;20809.37571872846;20825.479363015893;21093.47266318339;21302.254421095342;21338.57322853534;16139.273732682057;16562.917185413997;16673.91663041689;17129.314827406888;17321.566960825956;3622.9131260621707;3673.155174309897;3678.0988657779017;3680.263947210542;3681.4293784463453;103715;123353;135493.999999999;137418.31290843582;139826;17069.40257090996;17260.136993150543;17338.30646774115;17418.042007689444;17456.91271543634;29351.853240734086;29659.85170074179;29936.251593709894;29955.400891982037;30109.849450752605;9170.95414522923;9172.082791720775;9175.541222938826;9186.632534698538;9198.816023679623;3916.3342231820657;3930.9213815723524;3965.8017099145504;4048.3927410888014;4054.71616986814;4982.90034199314;5119.1553393690365;5133.204353325241;5133.922991155136;5164.7934082636275;995.5719040812376;1036.186593524095;1039.5322105052755;1048.4548035021899;1055.0609957138154;683.3200965039717;700.3206889317354;703.3002162848;707.5153519838824;716.0869890889054;11623.941880290544;12014;12328.50685972551;13031.15297505678;13238.338083096;672;676.5636164673856;682.310866025318;691.339770519163;696.0742212856889;5559.305086864142;5572.832815015556;5595.18869763882;5596.552275817925;5696.544276457874;119566;120791;122912;125524;128637.35681321533;105166;106896;107289.46355268174;110166;110576;94961;96206.11381658421;100518.49740751396;100778;100928.49535752274;10503.789924201626;10530.894691052992;10534.051935325857;10536.420496872746;10612.310199837295;43313;43850.561494384645;44120.55879441164;44704.10591788211;45073.77463112663;57325;57408.42591574031;58032.70983645055;58518;59741.402585975324;15653.921730391276;16050.919745401197;16138.515844524683;16224.513264602081;16316.265768040705;17379.913100434922;17483.56291092733;17572.82427175712;17655.823441765417;17847.46457606274;15798.289076991334;15814;15831.050136991817;15916;16085.115318657587;15440.691186176438;15452.613684657974;15611.765823512429;15793.842061579237;15805.762913556537;15595.922020389826;15757.763633545277;15790.368385264921;15933.36266549325;15938.203089845692;10146.898531014891;10226.13077888358;10261.076503114755;10360;10372.27394082407;11474.565679290088;11528.250663706833;11530.538778448768;11819.763604728028;11952.223105498115 05:38:56 INFO - PID 1175 | __end_tp_report 05:38:56 INFO - PID 1175 | __start_cc_report 05:38:56 INFO - PID 1175 | _x_x_mozilla_cycle_collect,380 05:38:56 INFO - PID 1175 | __end_cc_report 05:38:56 INFO - PID 1175 | __startTimestamp1505306336622__endTimestamp 05:38:56 INFO - PID 1175 | 05:38:56 INFO - PID 1175 | ------- Summary: start ------- 05:38:56 INFO - PID 1175 | Number of tests: 6 05:38:56 INFO - PID 1175 | 05:38:56 INFO - PID 1175 | [#0] dojo.html Cycles:165 Average:6210.37 Median:6485.22 stddev:890.66 (13.7%) stddev-sans-first:859.58 05:38:56 INFO - PID 1175 | Values: 3112.0 3145.2 3177.0 3179.0 3185.3 6243.3 6382.6 6394.8 6420.7 6468.9 6314.1 6353.4 6356.1 6394.4 6396.1 5816.4 5851.7 5927.6 5936.9 5946.6 5849.3 5889.5 5892.3 5927.6 5983.9 231.7 5621.9 5682.7 5714.9 5867.7 5806.8 5828.1 5848.4 5857.1 5892.8 5744.2 5785.9 5826.2 5834.9 5836.7 6280.6 6301.6 6365.4 6385.7 6401.8 6586.6 6743.5 6821.8 6877.6 6886.6 6783.5 6861.6 6969.4 6974.0 6976.7 6237.3 6407.5 6419.7 6485.2 6490.0 7008.2 7026.8 7142.8 7144.2 7144.7 6647.0 6653.2 6747.8 6747.9 6749.1 6699.0 6768.5 6804.7 6855.1 6861.6 6803.4 6804.1 6817.2 6828.9 6831.4 6830.6 6903.8 6908.8 6955.1 6958.4 5293.8 5310.8 5378.1 5409.8 5429.2 4509.3 4575.5 4581.0 4675.0 4684.6 5806.4 5874.6 5885.3 5912.9 5919.6 6609.9 6680.0 6768.0 6773.7 6816.1 5655.2 5728.2 5786.9 5814.5 5835.7 5801.9 5807.5 5912.7 5918.4 5932.9 6421.9 6438.2 6515.6 6520.0 6587.9 6668.8 6669.8 6734.3 6773.3 6787.3 6414.1 6417.9 6487.5 6531.1 6537.5 6632.8 6728.2 6731.6 6732.6 6759.9 6764.1 6784.7 6851.2 6862.2 6880.3 6452.9 6544.1 6549.0 6557.8 6557.9 6406.6 6498.6 6515.8 6571.5 6582.2 6429.2 6452.8 6483.6 6486.9 6512.1 6579.1 6624.9 6652.0 6689.9 6752.1 6495.1 6495.6 6529.0 6571.8 6576.9 05:38:56 INFO - PID 1175 | 05:38:56 INFO - PID 1175 | [#1] ext.html Cycles:180 Average:36979.30 Median:19677.20 stddev:50720.92 (257.8%) stddev-sans-first:50790.72 05:38:56 INFO - PID 1175 | Values: 867.8 878.1 897.3 898.4 898.8 38996.4 42502.4 42582.4 42636.1 42833.8 39233.4 39625.8 39662.0 39721.0 39763.8 7155.0 7294.3 7682.7 7906.9 7911.6 7866.3 7965.0 7965.2 7969.6 7975.2 7925.1 7966.6 7967.4 7967.9 7981.0 7922.2 7929.1 7940.2 7965.8 7979.8 7825.2 7875.4 7879.5 7879.6 7883.0 38670.8 38924.0 38956.0 38964.2 38996.0 3522.1 3523.2 3527.7 3549.9 3552.9 31546.2 31558.5 31565.5 31681.2 31699.4 5013.5 5190.4 5259.8 5272.0 5280.6 180384.0 180460.0 181940.0 182083.0 182532.0 42673.6 43520.3 49084.0 49183.0 49271.0 50201.5 50938.7 50989.5 51142.5 51260.0 15264.6 15295.9 15304.6 15319.0 15452.2 12307.6 12325.8 12332.1 12337.8 12379.8 13933.7 14047.5 14095.9 14126.1 14171.2 5758.3 5794.4 5830.9 5872.4 5889.7 1009.7 1026.4 1040.0 1040.8 1041.4 23032.8 23783.5 23803.3 24028.5 24107.3 1124.2 1132.1 1135.5 1144.4 1151.6 12160.0 12359.3 12450.5 12486.9 12657.5 220419.0 221015.0 222187.0 222618.0 222708.0 52622.0 52752.0 53216.5 53267.5 53755.5 1456.6 1470.7 1484.1 1500.2 1501.3 22755.9 22898.4 23112.4 23134.3 23170.5 37594.6 37778.8 37793.2 38110.0 38239.0 179068.0 181007.0 183386.0 183823.0 184309.0 34323.3 35801.5 36979.3 36997.0 37117.0 44413.8 45156.3 45844.1 45905.5 46309.8 33173.8 33198.7 33451.3 33812.8 34085.7 33689.0 33907.5 33942.0 33958.0 34464.5 37934.6 38073.4 38124.0 38581.0 38588.4 32630.2 33127.3 33131.2 33191.5 33516.8 23939.6 24799.8 25000.2 25261.7 25640.9 05:38:56 INFO - PID 1175 | 05:38:56 INFO - PID 1175 | [#2] jquery.html Cycles:180 Average:32788.79 Median:23103.86 stddev:72735.68 (314.8%) stddev-sans-first:72899.49 05:38:56 INFO - PID 1175 | Values: 564.4 569.2 570.3 577.8 588.6 21921.3 22648.9 22662.5 22686.2 22694.0 24190.3 24383.0 24695.9 24735.8 25605.9 6486.1 6627.5 6664.3 6672.6 6679.9 6372.3 6586.8 6673.8 6674.7 6677.8 6652.0 6660.6 6667.2 6684.8 6685.4 6216.3 6444.3 6451.2 6626.2 6656.0 6028.7 6036.7 6059.0 6061.9 6062.6 29297.9 29838.4 29842.7 29848.7 29854.6 2062.4 2089.3 2094.2 2095.5 2097.5 19365.4 19609.0 19916.3 20171.3 20176.8 2409.7 2439.3 2462.4 2462.9 2506.9 118922.0 123454.0 134612.0 140836.0 140950.6 14781.9 14864.8 14957.2 15032.7 15101.6 22998.2 23089.5 23118.2 23118.2 23191.7 10199.5 10243.7 10313.2 10381.9 10391.9 9580.2 9600.0 9632.2 9688.9 9723.8 9259.2 9419.8 9431.8 9448.8 9478.0 2658.9 2659.8 2710.5 2734.9 2750.2 940.7 962.6 964.7 968.1 971.0 18768.6 18915.9 18973.3 19102.4 19538.6 982.7 1008.3 1017.8 1023.2 1038.1 10323.2 10603.8 10780.2 10892.8 10928.7 411971.0 421471.0 434061.0 434391.0 436917.0 108723.0 110132.0 113335.4 115166.0 115927.4 1005.9 1075.3 1076.5 1107.1 1133.7 20560.4 20566.9 20611.2 20682.4 20921.7 56083.2 56124.7 56401.7 56634.0 58559.1 68540.3 69436.3 69465.7 70064.6 70144.3 14084.0 14400.1 14461.3 14475.9 14514.6 23120.3 23273.2 23327.0 23337.9 23563.3 18564.5 18754.2 18826.6 18850.6 18940.4 16464.8 16554.3 16565.6 17082.0 17368.0 18166.9 18312.4 18318.5 18395.0 18597.5 13957.7 14007.8 14030.6 14050.6 14108.4 17965.9 18056.0 18277.6 18451.6 18581.8 05:38:56 INFO - PID 1175 | 05:38:56 INFO - PID 1175 | [#3] mootools.html Cycles:180 Average:9225.10 Median:2465.30 stddev:6680.42 (271.0%) stddev-sans-first:6672.34 05:38:56 INFO - PID 1175 | Values: 1257.6 1343.5 1369.1 1371.5 1377.0 14654.1 15295.2 15344.4 15376.6 15381.8 14919.4 15004.5 15054.7 15064.3 15078.4 2515.4 2549.3 2558.5 2561.4 2565.0 2370.9 2479.7 2482.9 2502.8 2509.5 2243.0 2348.2 2461.7 2465.2 2465.3 2494.1 2501.8 2525.2 2534.7 2535.1 2393.4 2490.6 2515.6 2521.0 2527.4 14837.7 15011.4 15058.3 15062.1 15066.5 7411.7 7680.0 7705.8 7715.2 7725.6 5102.7 5231.3 5264.7 5338.5 5344.8 1832.5 1850.5 1862.5 1885.5 1888.1 26039.0 26082.3 26133.3 26301.0 26401.6 6205.8 6405.9 6407.1 6448.7 6536.2 17126.6 17202.1 17524.3 17542.8 17598.8 7416.3 7650.5 7685.9 7692.6 7722.3 7093.5 7119.4 7177.0 7413.1 7417.1 4966.8 5163.3 5169.9 5174.6 5196.2 1484.4 1492.5 1497.8 1505.6 1507.2 884.2 888.9 896.3 908.7 909.7 7498.9 7528.3 7532.3 7616.3 7633.1 703.3 728.5 731.5 732.6 733.6 4600.5 4607.5 5370.8 5425.9 5616.0 20311.2 21647.6 21695.8 21698.6 21712.0 21122.7 21455.4 21665.0 21683.5 21931.7 11502.7 11568.0 11600.9 11616.7 11654.1 8178.6 8494.7 8495.4 8541.5 8567.7 18045.0 18538.5 18789.8 18944.9 19136.5 18555.9 18769.7 18793.6 18833.2 18944.0 10663.8 10769.9 10831.6 10892.5 10897.6 13648.2 13705.2 13773.7 13851.4 13862.1 11020.2 11112.3 11351.7 11545.1 11633.9 10758.5 10852.6 11001.1 11023.7 11072.3 10026.7 10113.6 10122.6 10205.8 10207.0 7403.3 7446.7 7458.2 7506.5 7544.0 7454.0 7491.7 7586.1 7594.1 7661.5 05:38:56 INFO - PID 1175 | 05:38:56 INFO - PID 1175 | [#4] prototype.html Cycles:180 Average:5494.25 Median:6095.77 stddev:1526.07 (25.0%) stddev-sans-first:1483.71 05:38:56 INFO - PID 1175 | Values: 505.8 506.5 519.3 527.0 530.9 6229.9 6237.3 6263.6 6271.9 6278.3 6053.7 6061.0 6169.4 6179.5 6180.8 4901.3 5039.8 5081.9 5112.1 5131.1 4991.6 5074.0 5082.5 5092.4 5094.0 4924.8 4927.4 4968.6 4987.4 5007.7 4933.3 4973.5 5014.2 5014.4 5017.3 4489.7 4509.3 4517.3 4542.4 4551.7 5965.9 5996.9 6013.5 6130.6 6142.2 5700.4 5700.8 5713.8 5742.9 5773.9 6528.8 6587.8 6593.2 6612.9 6628.9 4854.6 4860.0 4869.8 4875.3 4921.3 6500.3 6536.9 6693.8 6812.6 6929.4 4927.5 4998.3 4999.4 5020.9 5028.5 5058.9 5074.6 5076.3 5087.0 5098.3 5643.6 5661.7 5677.4 5678.5 5746.4 6526.9 6565.2 6586.7 6604.7 6626.2 1702.8 1742.8 1761.6 1762.7 1763.0 1165.1 1193.6 1209.5 1228.3 1228.4 5612.2 5622.8 5631.4 5686.0 5697.8 6465.5 6549.4 6577.8 6632.9 6667.0 5546.6 5619.5 5646.8 5679.4 5706.9 3440.4 3445.7 3455.7 3484.5 3517.3 6291.8 6314.2 6392.8 6422.7 6431.1 6700.4 6764.5 6771.2 6780.8 6836.5 5914.6 6346.8 6365.3 6377.0 6433.9 6404.9 6483.3 6604.7 6610.5 6617.2 6469.9 6567.2 6592.6 6662.4 6702.7 6390.6 6451.6 6461.6 6497.2 6509.2 5420.5 5494.4 5514.1 5528.6 5581.2 6487.2 6664.3 6674.0 6898.9 6919.4 6495.3 6527.9 6533.6 6543.5 6641.4 6461.8 6477.9 6523.6 6561.4 6578.7 6483.3 6499.4 6501.4 6516.9 6523.6 6451.0 6470.2 6545.4 6552.0 6587.2 6198.3 6324.6 6398.4 6420.5 6485.2 05:38:56 INFO - PID 1175 | 05:38:56 INFO - PID 1175 | [#5] yui.html Cycles:180 Average:23924.70 Median:17907.28 stddev:34602.59 (193.2%) stddev-sans-first:34656.43 05:38:56 INFO - PID 1175 | Values: 890.6 894.9 920.2 922.1 931.3 17193.3 17527.7 17624.8 17631.4 17632.1 17556.6 17903.6 17910.9 17977.6 17994.7 968.0 968.7 972.0 972.5 972.8 953.9 955.2 956.6 956.8 973.9 995.7 1011.7 1011.9 1018.5 1031.4 994.3 999.0 1010.6 1011.4 1027.3 725.5 741.2 744.1 748.7 749.6 18817.7 18854.9 18933.9 18974.1 18991.3 20809.4 20825.5 21093.5 21302.3 21338.6 16139.3 16562.9 16673.9 17129.3 17321.6 3622.9 3673.2 3678.1 3680.3 3681.4 103715.0 123353.0 135494.0 137418.3 139826.0 17069.4 17260.1 17338.3 17418.0 17456.9 29351.9 29659.9 29936.3 29955.4 30109.8 9171.0 9172.1 9175.5 9186.6 9198.8 3916.3 3930.9 3965.8 4048.4 4054.7 4982.9 5119.2 5133.2 5133.9 5164.8 995.6 1036.2 1039.5 1048.5 1055.1 683.3 700.3 703.3 707.5 716.1 11623.9 12014.0 12328.5 13031.2 13238.3 672.0 676.6 682.3 691.3 696.1 5559.3 5572.8 5595.2 5596.6 5696.5 119566.0 120791.0 122912.0 125524.0 128637.4 105166.0 106896.0 107289.5 110166.0 110576.0 94961.0 96206.1 100518.5 100778.0 100928.5 10503.8 10530.9 10534.1 10536.4 10612.3 43313.0 43850.6 44120.6 44704.1 45073.8 57325.0 57408.4 58032.7 58518.0 59741.4 15653.9 16050.9 16138.5 16224.5 16316.3 17379.9 17483.6 17572.8 17655.8 17847.5 15798.3 15814.0 15831.1 15916.0 16085.1 15440.7 15452.6 15611.8 15793.8 15805.8 15595.9 15757.8 15790.4 15933.4 15938.2 10146.9 10226.1 10261.1 10360.0 10372.3 11474.6 11528.3 11530.5 11819.8 11952.2 05:38:56 INFO - PID 1175 | -------- Summary: end -------- 05:38:56 INFO - PID 1175 | 05:38:56 INFO - PID 1175 | 05:38:56 INFO - PID 1175 | ###!!! [Parent][RunMessage] Error: Channel closing: too late to send/recv, messages will be lost 05:38:56 INFO - PID 1175 | 05:38:57 INFO - TEST-INFO | 1175: exit 0 05:38:57 INFO - TEST-OK | dromaeo_css | took 1107783ms 05:38:57 INFO - TEST-START | kraken 05:38:57 INFO - Initialising browser for kraken test... 05:38:57 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:48248/getInfo.html -profile /tmp/tmplX98xM/profile 05:38:57 INFO - TEST-INFO | started process 1608 (/builds/slave/test/build/application/firefox/firefox http://localhost:48248/getInfo.html) 05:39:01 INFO - TEST-INFO | 1608: exit 0 05:39:02 INFO - Browser initialized. 05:39:02 INFO - Running cycle 1/1 for kraken test... 05:39:02 INFO - Using env: {'DISPLAY': ':0', 05:39:02 INFO - 'HOME': '/home/cltbld', 05:39:02 INFO - 'JSGC_DISABLE_POISONING': '1', 05:39:02 INFO - 'LANG': 'en_US.UTF-8', 05:39:02 INFO - 'LANGUAGE': 'en_US:en', 05:39:02 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 05:39:02 INFO - 'LOGNAME': 'cltbld', 05:39:02 INFO - 'MAIL': '/var/mail/cltbld', 05:39:02 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:39:02 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:39:02 INFO - 'MOZ_CRASHREPORTER': '1', 05:39:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:39:02 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 05:39:02 INFO - 'MOZ_NO_REMOTE': '1', 05:39:02 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:39:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:39:02 INFO - 'NO_EM_RESTART': '1', 05:39:02 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:39:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:39:02 INFO - 'PWD': '/builds/slave/test', 05:39:02 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:39:02 INFO - 'RUST_BACKTRACE': 'full', 05:39:02 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 05:39:02 INFO - 'SHELL': '/bin/bash', 05:39:02 INFO - 'SHLVL': '1', 05:39:02 INFO - 'STYLO_FORCE_DISABLED': '1', 05:39:02 INFO - 'TERM': 'linux', 05:39:02 INFO - 'TMOUT': '86400', 05:39:02 INFO - 'USER': 'cltbld', 05:39:02 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1505300237.672302-631552636', 05:39:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:39:02 INFO - '_': '/tools/buildbot/bin/python'} 05:39:02 INFO - TEST-INFO | started process 1794 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmplX98xM/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 05:39:02 INFO - PID 1794 | 05:39:02 INFO - PID 1794 | (/builds/slave/test/build/application/firefox/firefox:1843): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 05:39:02 INFO - PID 1794 | 05:39:13 INFO - PID 1794 | RSS: Main: 173187072 05:39:13 INFO - PID 1794 | 05:39:16 INFO - PID 1794 | Cycle 1(1): loaded http://localhost:48248/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:48248/tests/kraken/driver.html?testName=audio-beat-detection) 05:39:16 INFO - PID 1794 | RSS: Main: 177823744 05:39:16 INFO - PID 1794 | 05:39:19 INFO - PID 1794 | Cycle 1(1): loaded http://localhost:48248/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:48248/tests/kraken/driver.html?testName=audio-dft) 05:39:20 INFO - PID 1794 | RSS: Main: 178601984 05:39:20 INFO - PID 1794 | 05:39:23 INFO - PID 1794 | Cycle 1(1): loaded http://localhost:48248/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:48248/tests/kraken/driver.html?testName=audio-fft) 05:39:23 INFO - PID 1794 | RSS: Main: 174231552 05:39:23 INFO - PID 1794 | 05:39:25 INFO - PID 1794 | Cycle 1(1): loaded http://localhost:48248/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:48248/tests/kraken/driver.html?testName=audio-oscillator) 05:39:26 INFO - PID 1794 | RSS: Main: 174841856 05:39:26 INFO - PID 1794 | 05:39:28 INFO - PID 1794 | Cycle 1(1): loaded http://localhost:48248/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:48248/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:39:29 INFO - PID 1794 | RSS: Main: 174944256 05:39:29 INFO - PID 1794 | 05:39:32 INFO - PID 1794 | Cycle 1(1): loaded http://localhost:48248/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:48248/tests/kraken/driver.html?testName=imaging-darkroom) 05:39:33 INFO - PID 1794 | RSS: Main: 177905664 05:39:33 INFO - PID 1794 | 05:39:36 INFO - PID 1794 | Cycle 1(1): loaded http://localhost:48248/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:48248/tests/kraken/driver.html?testName=imaging-desaturate) 05:39:37 INFO - PID 1794 | RSS: Main: 177541120 05:39:37 INFO - PID 1794 | 05:39:40 INFO - PID 1794 | Cycle 1(1): loaded http://localhost:48248/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:48248/tests/kraken/driver.html?testName=json-parse-financial) 05:39:41 INFO - PID 1794 | RSS: Main: 178151424 05:39:41 INFO - PID 1794 | 05:39:42 INFO - PID 1794 | Cycle 1(1): loaded http://localhost:48248/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:48248/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:39:43 INFO - PID 1794 | RSS: Main: 178040832 05:39:43 INFO - PID 1794 | 05:39:44 INFO - PID 1794 | Cycle 1(1): loaded http://localhost:48248/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:48248/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:39:45 INFO - PID 1794 | RSS: Main: 178184192 05:39:45 INFO - PID 1794 | 05:39:47 INFO - PID 1794 | Cycle 1(1): loaded http://localhost:48248/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:48248/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:39:48 INFO - PID 1794 | RSS: Main: 174882816 05:39:48 INFO - PID 1794 | 05:39:51 INFO - PID 1794 | Cycle 1(1): loaded http://localhost:48248/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:48248/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:39:51 INFO - PID 1794 | RSS: Main: 175390720 05:39:51 INFO - PID 1794 | 05:39:54 INFO - PID 1794 | Cycle 1(1): loaded http://localhost:48248/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:48248/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:39:55 INFO - PID 1794 | RSS: Main: 175177728 05:39:55 INFO - PID 1794 | 05:39:57 INFO - PID 1794 | Cycle 1(1): loaded http://localhost:48248/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:48248/tests/kraken/driver.html?testName=ai-astar) 05:39:57 INFO - PID 1794 | RSS: Main: 176685056 05:39:57 INFO - PID 1794 | 05:39:57 INFO - PID 1794 | __start_tp_report 05:39:57 INFO - PID 1794 | _x_x_mozilla_page_load 05:39:57 INFO - PID 1794 | _x_x_mozilla_page_load_details 05:39:57 INFO - PID 1794 | |i|pagename|runs| 05:39:57 INFO - PID 1794 | |0;ai-astar;108;110;109;107;110;108;114;109;113;108 05:39:57 INFO - PID 1794 | |1;audio-beat-detection;117;120;116;119;118;117;117;119;148;121 05:39:57 INFO - PID 1794 | |2;audio-dft;165;162;162;165;163;164;172;170;165;164 05:39:57 INFO - PID 1794 | |3;audio-fft;76;77;72;73;73;74;73;76;77;79 05:39:57 INFO - PID 1794 | |4;audio-oscillator;80;79;81;82;79;80;79;79;80;79 05:39:57 INFO - PID 1794 | |5;imaging-gaussian-blur;114;110;114;113;113;113;114;115;116;117 05:39:57 INFO - PID 1794 | |6;imaging-darkroom;149;148;150;150;150;148;148;148;148;148 05:39:57 INFO - PID 1794 | |7;imaging-desaturate;99;94;95;94;94;95;94;94;94;94 05:39:57 INFO - PID 1794 | |8;json-parse-financial;55;57;57;55;53;55;55;53;54;54 05:39:57 INFO - PID 1794 | |9;json-stringify-tinderbox;38;38;38;38;38;38;37;38;38;38 05:39:57 INFO - PID 1794 | |10;stanford-crypto-aes;78;77;75;76;75;75;75;74;75;75 05:39:57 INFO - PID 1794 | |11;stanford-crypto-ccm;110;118;118;116;112;118;113;120;116;112 05:39:57 INFO - PID 1794 | |12;stanford-crypto-pbkdf2;171;169;170;168;168;174;170;168;166;171 05:39:57 INFO - PID 1794 | |13;stanford-crypto-sha256-iterative;67;70;74;70;64;66;65;66;67;65 05:39:57 INFO - PID 1794 | __end_tp_report 05:39:57 INFO - PID 1794 | __start_cc_report 05:39:57 INFO - PID 1794 | _x_x_mozilla_cycle_collect,945 05:39:57 INFO - PID 1794 | __end_cc_report 05:39:57 INFO - PID 1794 | __startTimestamp1505306397284__endTimestamp 05:39:57 INFO - PID 1794 | 05:39:57 INFO - PID 1794 | ------- Summary: start ------- 05:39:57 INFO - PID 1794 | Number of tests: 14 05:39:57 INFO - PID 1794 | 05:39:57 INFO - PID 1794 | [#0] ai-astar Cycles:10 Average:109.60 Median:109.50 stddev:2.27 (2.1%) stddev-sans-first:2.33 05:39:57 INFO - PID 1794 | Values: 108.0 110.0 109.0 107.0 110.0 108.0 114.0 109.0 113.0 108.0 05:39:57 INFO - PID 1794 | 05:39:57 INFO - PID 1794 | [#1] audio-beat-detection Cycles:10 Average:121.20 Median:119.00 stddev:9.54 (8.0%) stddev-sans-first:10.00 05:39:57 INFO - PID 1794 | Values: 117.0 120.0 116.0 119.0 118.0 117.0 117.0 119.0 148.0 121.0 05:39:57 INFO - PID 1794 | 05:39:57 INFO - PID 1794 | [#2] audio-dft Cycles:10 Average:165.20 Median:165.00 stddev:3.29 (2.0%) stddev-sans-first:3.49 05:39:57 INFO - PID 1794 | Values: 165.0 162.0 162.0 165.0 163.0 164.0 172.0 170.0 165.0 164.0 05:39:57 INFO - PID 1794 | 05:39:57 INFO - PID 1794 | [#3] audio-fft Cycles:10 Average:75.00 Median:76.00 stddev:2.31 (3.0%) stddev-sans-first:2.42 05:39:57 INFO - PID 1794 | Values: 76.0 77.0 72.0 73.0 73.0 74.0 73.0 76.0 77.0 79.0 05:39:57 INFO - PID 1794 | 05:39:57 INFO - PID 1794 | [#4] audio-oscillator Cycles:10 Average:79.80 Median:80.00 stddev:1.03 (1.3%) stddev-sans-first:1.09 05:39:57 INFO - PID 1794 | Values: 80.0 79.0 81.0 82.0 79.0 80.0 79.0 79.0 80.0 79.0 05:39:57 INFO - PID 1794 | 05:39:57 INFO - PID 1794 | [#5] imaging-gaussian-blur Cycles:10 Average:113.90 Median:114.00 stddev:1.91 (1.7%) stddev-sans-first:2.03 05:39:57 INFO - PID 1794 | Values: 114.0 110.0 114.0 113.0 113.0 113.0 114.0 115.0 116.0 117.0 05:39:57 INFO - PID 1794 | 05:39:57 INFO - PID 1794 | [#6] imaging-darkroom Cycles:10 Average:148.70 Median:148.50 stddev:0.95 (0.6%) stddev-sans-first:1.00 05:39:57 INFO - PID 1794 | Values: 149.0 148.0 150.0 150.0 150.0 148.0 148.0 148.0 148.0 148.0 05:39:57 INFO - PID 1794 | 05:39:57 INFO - PID 1794 | [#7] imaging-desaturate Cycles:10 Average:94.70 Median:94.00 stddev:1.57 (1.7%) stddev-sans-first:0.44 05:39:57 INFO - PID 1794 | Values: 99.0 94.0 95.0 94.0 94.0 95.0 94.0 94.0 94.0 94.0 05:39:57 INFO - PID 1794 | 05:39:57 INFO - PID 1794 | [#8] json-parse-financial Cycles:10 Average:54.80 Median:55.00 stddev:1.40 (2.5%) stddev-sans-first:1.48 05:39:57 INFO - PID 1794 | Values: 55.0 57.0 57.0 55.0 53.0 55.0 55.0 53.0 54.0 54.0 05:39:57 INFO - PID 1794 | 05:39:57 INFO - PID 1794 | [#9] json-stringify-tinderbox Cycles:10 Average:37.90 Median:38.00 stddev:0.32 (0.8%) stddev-sans-first:0.33 05:39:57 INFO - PID 1794 | Values: 38.0 38.0 38.0 38.0 38.0 38.0 37.0 38.0 38.0 38.0 05:39:57 INFO - PID 1794 | 05:39:57 INFO - PID 1794 | [#10] stanford-crypto-aes Cycles:10 Average:75.50 Median:75.00 stddev:1.18 (1.6%) stddev-sans-first:0.83 05:39:57 INFO - PID 1794 | Values: 78.0 77.0 75.0 76.0 75.0 75.0 75.0 74.0 75.0 75.0 05:39:57 INFO - PID 1794 | 05:39:57 INFO - PID 1794 | [#11] stanford-crypto-ccm Cycles:10 Average:115.30 Median:117.00 stddev:3.33 (2.9%) stddev-sans-first:2.93 05:39:57 INFO - PID 1794 | Values: 110.0 118.0 118.0 116.0 112.0 118.0 113.0 120.0 116.0 112.0 05:39:57 INFO - PID 1794 | 05:39:57 INFO - PID 1794 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:169.50 Median:170.00 stddev:2.22 (1.3%) stddev-sans-first:2.29 05:39:57 INFO - PID 1794 | Values: 171.0 169.0 170.0 168.0 168.0 174.0 170.0 168.0 166.0 171.0 05:39:57 INFO - PID 1794 | 05:39:57 INFO - PID 1794 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.40 Median:67.00 stddev:3.06 (4.6%) stddev-sans-first:3.24 05:39:57 INFO - PID 1794 | Values: 67.0 70.0 74.0 70.0 64.0 66.0 65.0 66.0 67.0 65.0 05:39:57 INFO - PID 1794 | -------- Summary: end -------- 05:39:57 INFO - PID 1794 | 05:39:57 INFO - PID 1794 | 05:39:57 INFO - PID 1794 | ###!!! [Parent][RunMessage] Error: Channel closing: too late to send/recv, messages will be lost 05:39:57 INFO - PID 1794 | 05:39:57 INFO - PID 1794 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 05:39:57 INFO - TEST-INFO | 1794: exit 0 05:39:57 INFO - TEST-OK | kraken | took 60738ms 05:39:57 INFO - SUITE-END | took 1168s 05:39:58 INFO - Completed test suite (00:19:28) 05:39:58 INFO - javascript benchmark 05:39:58 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s", "stylo_disabled"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8453.937771062727, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3111.9688803111967, 3145.24514116612, 3177.046885934219, 3178.952315715263, 3185.347003864208, 6243.282022567406, 6382.648954307511, 6394.808155755329, 6420.678966051696, 6468.932626116697, 6314.1475900753385, 6353.396427339407, 6356.110144579762, 6394.369435793866, 6396.072569477423, 5816.418358164171, 5851.678157701314, 5927.585069045169, 5936.88126237475, 5946.554008449362, 5849.327327357345, 5889.528837692996, 5892.292924849003, 5927.644341339534, 5983.910241346383, 231.7422149099679, 5621.943780562183, 5682.744276507547, 5714.885702285952, 5867.706614669292, 5806.83863227352, 5828.125781132864, 5848.356680765112, 5857.121431785266, 5892.764289428418, 5744.224529688522, 5785.913211301834, 5826.2134611827705, 5834.883302333972, 5836.708164591753, 6280.623162610213, 6301.558890877641, 6365.427111559982, 6385.712642931079, 6401.807945761635, 6586.637734924578, 6743.4942379321255, 6821.761238356634, 6877.6217308048535, 6886.621235832027, 6783.457323414115, 6861.588304701734, 6969.372756451944, 6974.0236366908675, 6976.651167441659, 6237.313895471494, 6407.519436042316, 6419.743210271584, 6485.221773387177, 6490.026496025586, 7008.229094799619, 7026.789196324118, 7142.750003749844, 7144.249853765384, 7144.714211431485, 6647.0029495576055, 6653.234877989094, 6747.797566073025, 6747.932520674829, 6749.0551322814845, 6698.966505167443, 6768.526203165829, 6804.693788779517, 6855.143107111611, 6861.622610756356, 6803.421709154678, 6804.08144900442, 6817.181938167451, 6828.897566536506, 6831.385175334144, 6830.59016459014, 6903.75836845708, 6908.758193463204, 6955.130608673916, 6958.408535274457, 5293.841184764463, 5310.814121505806, 5378.139497680352, 5409.810656626999, 5429.239906413105, 4509.255972764523, 4575.519570445122, 4580.977095114503, 4675.018246168343, 4684.578387945101, 5806.4193580641595, 5874.588778785529, 5885.264341957255, 5912.881742365129, 5919.55603329752, 6609.867802644017, 6680.0, 6767.966160169266, 6773.72905083801, 6816.147981502312, 5655.1799989001365, 5728.226689396962, 5786.855328616818, 5814.505767009767, 5835.679037652885, 5801.9129713054335, 5807.535397168216, 5912.674802885796, 5918.4377484139795, 5932.940670593325, 6421.903671444932, 6438.163038805019, 6515.641639709766, 6519.956806910872, 6587.901181482282, 6668.766593169215, 6669.799906002828, 6734.259231484631, 6773.288804675438, 6787.321267873173, 6414.134091897534, 6417.903731443938, 6487.513436492188, 6531.11829902957, 6537.5096867734155, 6632.772937006669, 6728.158980127484, 6731.596104233761, 6732.5525012122625, 6759.932400675931, 6764.0868482754195, 6784.694688739118, 6851.246362900177, 6862.245153033262, 6880.277570854988, 6452.870942581216, 6544.051112588743, 6549.0, 6557.770478033246, 6557.901631475436, 6406.583572067801, 6498.577592456475, 6515.771947981798, 6571.507136964842, 6582.210134783665, 6429.2284925807335, 6452.774152904626, 6483.643399612878, 6486.902696459462, 6512.05575191604, 6579.144711187515, 6624.900626490703, 6652.0, 6689.866202675822, 6752.054712340178, 6495.123158373559, 6495.610263384212, 6529.0, 6571.817072926728, 6576.868462630816], "value": 6145.078560404387, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [867.7526904832124, 878.1262643669546, 897.3404547657467, 898.3621628643663, 898.8247291778104, 38996.41505377418, 42502.362464563055, 42582.36126458102, 42636.14727705444, 42833.78583107084, 39233.41149882754, 39625.8018709906, 39662.0, 39721.0, 39763.80118099406, 7154.96422517888, 7294.307040831112, 7682.731104411347, 7906.881396779053, 7911.604419779017, 7866.331361834251, 7964.960175199116, 7965.203479652047, 7969.641366138538, 7975.162607926171, 7925.128235894047, 7966.601669916481, 7967.402444816662, 7967.880481792778, 7981.0422749270165, 7922.207779222089, 7929.088154862207, 7940.2059794020715, 7965.800854978614, 7979.840403191962, 7825.178356272566, 7875.369970402354, 7879.487833290817, 7879.566623835687, 7882.960585197037, 38670.80664596687, 38924.0, 38956.02609934746, 38964.22071558581, 38996.0, 3522.066652337107, 3523.1896663767475, 3527.7177825773874, 3549.9290014199573, 3552.928941421183, 31546.211344716336, 31558.526622100686, 31565.526517102262, 31681.20796980094, 31699.36601267985, 5013.548780609763, 5190.429052804188, 5259.76331065103, 5272.0, 5280.551153151987, 180384.0, 180460.0, 181940.0, 182082.99999999866, 182532.0, 42673.57326426758, 43520.347194792106, 49084.0, 49183.0, 49271.0, 50201.49798502041, 50938.74530627397, 50989.49010509922, 51142.48857511377, 51260.0, 15264.618384540476, 15295.923520382326, 15304.617384565476, 15319.0, 15452.227388630523, 12307.630771076882, 12325.753484930252, 12332.136750427384, 12337.814932776015, 12379.823916727897, 13933.651658708613, 14047.508337208148, 14095.929520352332, 14126.081804682663, 14171.220582868042, 5758.2514273144225, 5794.391588883191, 5830.912536311958, 5872.442117998783, 5889.705514724246, 1009.6970908727352, 1026.3636545341787, 1040.0, 1040.8386700061503, 1041.375174895057, 23032.7696723034, 23783.52432951366, 23803.285901422638, 24028.51942961131, 24107.27678169658, 1124.24675467437, 1132.0717012050204, 1135.4663308245113, 1144.4277861069465, 1151.5681619392728, 12160.022377957705, 12359.269702241694, 12450.501979920882, 12486.937565312297, 12657.493700251887, 220419.0, 221015.0, 222187.0, 222618.0, 222708.0, 52622.0, 52752.0, 53216.46783532193, 53267.46732532625, 53755.46244537583, 1456.6139972907188, 1470.7426200414884, 1484.139199264424, 1500.2423775993054, 1501.2718831366778, 22755.88622056879, 22898.42753931165, 23112.4221894454, 23134.305970820904, 23170.536589268457, 37594.624053759115, 37778.811105944296, 37793.24413511659, 38110.0, 38239.0, 179068.0, 181007.0, 183386.0, 183823.0, 184309.0, 34323.31353372869, 35801.46297805483, 36979.260414792094, 36997.0, 37117.0, 44413.77793111014, 45156.32265516085, 45844.08311833678, 45905.540944590124, 46309.76845115753, 33173.83413082919, 33198.668013319555, 33451.330973380886, 33812.830935845166, 34085.65914340825, 33689.0, 33907.4913876297, 33942.0, 33958.0, 34464.48303275503, 37934.62065379421, 38073.4288985671, 38124.0, 38581.0, 38588.42117368298, 32630.184245394055, 33127.33745325128, 33131.17172070718, 33191.50212746859, 33516.832415837765, 23939.640905386084, 24799.752002480465, 25000.249992500256, 25261.74738252594, 25640.871795641648], "value": 17317.45719887304, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [564.3791828988113, 569.2059576890235, 570.2700543304571, 577.8064348443271, 588.6085752974273, 21921.342359729195, 22648.88675556622, 22662.54674906503, 22686.205982790605, 22694.0, 24190.274291771275, 24383.02467901282, 24695.876520617418, 24735.75264247357, 25605.87197064012, 6486.091947127394, 6627.46980241582, 6664.333566643345, 6672.633005184713, 6679.899801502981, 6372.267189273247, 6586.80239592813, 6673.766418175364, 6674.699638516278, 6677.799666010027, 6652.0, 6660.567063140905, 6667.199936007686, 6684.766033188839, 6685.398314151726, 6216.316205217445, 6444.291127975919, 6451.1936007999, 6626.237982631987, 6656.0348749431305, 6028.698565071729, 6036.728347224342, 6058.96970515149, 6061.909071363933, 6062.575619706622, 29297.853510732522, 29838.40323193524, 29842.70157298421, 29848.701512985026, 29854.552181717292, 2062.4019034479984, 2089.3314139475374, 2094.1623350659706, 2095.4551816527814, 2097.528056187361, 19365.4190374289, 19609.019549022636, 19916.302929397545, 20171.294004709765, 20176.798232017787, 2409.6506006629115, 2439.292605144506, 2462.409021834747, 2462.901483940658, 2506.9247922562354, 118922.0, 123454.0, 134612.0, 140836.0, 140950.59049409477, 14781.92609036948, 14864.777028344584, 14957.194476513161, 15032.699346013018, 15101.620530046383, 22998.19506317271, 23089.538209236056, 23118.1908633197, 23118.1908633197, 23191.652125218134, 10199.490025498695, 10243.7439064024, 10313.226508011929, 10381.9480902595, 10391.948040259751, 9580.233581313478, 9599.952000239955, 9632.181264592587, 9688.90311096894, 9723.805523889625, 9259.166674999282, 9419.764505887408, 9431.821022372204, 9448.779536808845, 9477.952610236905, 2658.8803503842373, 2659.7739192168883, 2710.52565800988, 2734.931626709348, 2750.2436829871544, 940.6519587752575, 962.5812771444444, 964.7346979580531, 968.1431932739576, 970.9659212938199, 18768.62462750737, 18915.90542047281, 18973.335933242546, 19102.426927192206, 19538.609227815363, 982.7395740128871, 1008.3294609085023, 1017.7685001148693, 1023.1967905194387, 1038.1020417338948, 10323.174146068297, 10603.84094238587, 10780.191485638608, 10892.836607450894, 10928.726781830517, 411971.0, 421471.0, 434061.0, 434391.0, 436917.0, 108723.0, 110132.0, 113335.4333228345, 115166.0, 115927.42036289764, 1005.8792944846518, 1075.2526993739275, 1076.5155679944057, 1107.0866535108407, 1133.699569614053, 20560.38318850437, 20566.897165514078, 20611.17555297831, 20682.379528614165, 20921.686174707087, 56083.15875261956, 56124.719376402856, 56401.71799140978, 56634.0, 58559.12161317498, 68540.31459685539, 69436.305636945, 69465.65267173632, 70064.64967675129, 70144.29855701582, 14084.0, 14400.135991840523, 14461.349239284047, 14475.85524144745, 14514.564563063124, 23120.306390808302, 23273.185438509572, 23327.0, 23337.88331058334, 23563.293101206993, 18564.535886602942, 18754.249830007193, 18826.623467530848, 18850.586206034877, 18940.43178704641, 16464.83535164681, 16554.255058522634, 16565.58586035359, 17082.0, 17368.0, 18166.90916545409, 18312.359067432575, 18318.450446486626, 18395.0, 18597.535061623028, 13957.720845582828, 14007.789883151558, 14030.57908262713, 14050.578482645536, 14108.435662573382, 17965.910170449064, 18056.0, 18277.634447311244, 18451.630967380308, 18581.81418185855], "value": 11908.32341473982, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1257.647858599592, 1343.5297645823969, 1369.1100784490084, 1371.4856928651755, 1376.9931150344241, 14654.120752754829, 15295.235238238085, 15344.386224551004, 15376.61558461039, 15381.846181538182, 14919.403223871032, 15004.474843380483, 15054.698906021873, 15064.32210550525, 15078.396864125421, 2515.3837309859064, 2549.31168584483, 2558.4883023395396, 2561.3596600849787, 2565.0381107084845, 2370.8933098010543, 2479.7396273391214, 2482.8758562071916, 2502.78726308264, 2509.5357358888573, 2242.955140897181, 2348.201611452106, 2461.655368248447, 2465.2480993297036, 2465.3466831289634, 2494.102123235652, 2501.849889006656, 2525.217182673377, 2534.6831646044243, 2535.1000394859834, 2393.389685630171, 2490.6264060390904, 2515.6478093066985, 2521.042004038472, 2527.4186937004592, 14837.703245935129, 15011.399544018226, 15058.32237549313, 15062.096274223471, 15066.548003559801, 7411.740589079411, 7680.0, 7705.807354816175, 7715.151333353327, 7725.613719314012, 5102.668326558799, 5231.305877473066, 5264.684118952837, 5338.519533241988, 5344.759485823147, 1832.4777438430117, 1850.5188650950715, 1862.4505770797648, 1885.5286178455385, 1888.1314595286185, 26039.0, 26082.34794130143, 26133.346666333302, 26301.0, 26401.603975940376, 6205.844853878689, 6405.903911441239, 6407.13503677007, 6448.709808058648, 6536.24833144185, 17126.571835704206, 17202.1398930053, 17524.299028038735, 17542.824571754376, 17598.82401175972, 7416.25837416254, 7650.4644674872225, 7685.923140768521, 7692.615369231516, 7722.3436007938835, 7093.503454758117, 7119.3948514375825, 7177.0, 7413.147488038837, 7417.147028091731, 4966.801327946841, 5163.251328557338, 5169.948300517022, 5174.611904107207, 5196.246544251062, 1484.406237504985, 1492.4627134231669, 1497.8202615686187, 1505.631120375493, 1507.186119495482, 884.2307192742355, 888.9377743558018, 896.2964073202505, 908.6910450446879, 909.7088931541975, 7498.887516687145, 7528.322450979438, 7532.284432978859, 7616.314531692175, 7633.084029916335, 703.268600655323, 728.5155371677774, 731.5171986488998, 732.5641243460133, 733.6441825714525, 4600.5169457207185, 4607.516210797818, 5370.812021579226, 5425.9186112208345, 5616.045272303718, 20311.187552497733, 21647.567048659253, 21695.783042169376, 21698.56602867934, 21712.0, 21122.683159752614, 21455.356339309845, 21665.0, 21683.45791355197, 21931.67102493464, 11502.654920352403, 11568.0, 11600.88399116015, 11616.709582260342, 11654.067674586013, 8178.591070446335, 8494.660213591387, 8495.447795893248, 8541.487510749375, 8567.74296771098, 18045.0, 18538.536536586154, 18789.812101878808, 18944.905275473535, 19136.521586960436, 18555.90722046381, 18769.718454222926, 18793.624127517647, 18833.24667013359, 18944.0, 10663.840042399526, 10769.9461502692, 10831.620893268699, 10892.509837057192, 10897.618583349546, 13648.181109133484, 13705.177689338672, 13773.724525509233, 13851.376688049264, 13862.098963567336, 11020.173486988348, 11112.277701949348, 11351.659450216506, 11545.076393888301, 11633.941830290794, 10758.515866785858, 10852.565897364333, 11001.064909482784, 11023.669289921316, 11072.280301780358, 10026.749331266778, 10113.64602238918, 10122.645707400206, 10205.846912296172, 10207.0, 7403.259674032553, 7446.664900079618, 7458.179600244077, 7506.512076714996, 7544.0, 7454.0, 7491.70033198666, 7586.089669239726, 7594.088709354692, 7661.540307581563], "value": 6488.053045916402, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [505.80273693259613, 506.47832732285747, 519.3352508788751, 526.9868253293668, 530.8991291654588, 6229.906551401721, 6237.251529816417, 6263.561550691454, 6271.905921411182, 6278.2779980302275, 6053.667048312341, 6060.969695151518, 6169.352218017111, 6179.536534759888, 6180.783672571461, 4901.289313049623, 5039.7732102055315, 5081.856582268978, 5112.130937740574, 5131.050755610206, 4991.550760431561, 5073.974630126862, 5082.491750824906, 5092.414372347172, 5094.0, 4924.778384972685, 4927.359443272369, 4968.627352948525, 4987.401511818587, 5007.724575148365, 4933.284673722308, 4973.477784832613, 5014.24786282057, 5014.398272207359, 5017.297578338999, 4489.685721999462, 4509.323601459774, 4517.299818528133, 4542.38677778499, 4551.749653769041, 5965.940340596625, 5996.8500787480225, 6013.458788709037, 6130.570860039799, 6142.170806941051, 5700.37295897451, 5700.7719691212305, 5713.8285851424525, 5742.913856292159, 5773.9422605773825, 6528.81284769598, 6587.835304117388, 6593.241777195636, 6612.86774264512, 6628.8674226515195, 4854.563089321942, 4859.951400485986, 4869.82955596556, 4875.293082503017, 4921.335619691332, 6500.284968653492, 6536.934630653727, 6693.799186024378, 6812.557183783038, 6929.44564434844, 4927.482614325444, 4998.275250088716, 4999.42506611737, 5020.949790502122, 5028.522290382408, 5058.898822023539, 5074.568661663726, 5076.340075790124, 5086.9745651271505, 5098.337216161875, 5643.633163844419, 5661.688607126565, 5677.432256774372, 5678.501459357952, 5746.4253574643035, 6526.902096468557, 6565.179352580927, 6586.7035983380865, 6604.735810567524, 6626.171728533934, 1702.838230368113, 1742.7821522309712, 1761.5772214668386, 1762.6739053275185, 1762.9559261018578, 1165.1145129701488, 1193.5524178433088, 1209.5464200924653, 1228.263042174688, 1228.3796682675193, 5612.20409468966, 5622.803201887914, 5631.436856314336, 5685.971570142123, 5697.772089116389, 6465.515086368541, 6549.443297319781, 6577.7635603894905, 6632.933670663231, 6667.0, 5546.556275498031, 5619.522340601095, 5646.774129034792, 5679.399686254147, 5706.914396284059, 3440.36353274645, 3445.6898879101, 3455.6825447570113, 3484.4773284007097, 3517.3317069756663, 6291.811245662638, 6314.210723659543, 6392.776252831221, 6422.743090276336, 6431.13179720741, 6700.363465470772, 6764.458843292525, 6771.221309549366, 6780.762673306411, 6836.4530837532875, 5914.615549989237, 6346.809595712136, 6365.2679941806355, 6377.0, 6433.871322573522, 6404.88638749221, 6483.272118531957, 6604.664644354571, 6610.504212184202, 6617.172853393326, 6469.870602587827, 6567.179102612174, 6592.637404942774, 6662.400383965466, 6702.698378572878, 6390.616563006234, 6451.612903225821, 6461.57999730016, 6497.220333560003, 6509.218893732783, 5420.4850539198715, 5494.423085575957, 5514.09017512106, 5528.585356098389, 5581.190727344593, 6487.15116191883, 6664.300248473841, 6674.0, 6898.896516552155, 6919.446444284546, 6495.285518593046, 6527.934720652733, 6533.575317604531, 6543.476521878143, 6641.402273795382, 6461.8061458156335, 6477.931141361622, 6523.64119973406, 6561.376669216417, 6578.703958321791, 6483.319251478527, 6499.415052645285, 6501.382368674968, 6516.924707423222, 6523.629168457051, 6451.0, 6470.158879345655, 6545.429097016777, 6551.967240163959, 6587.242467116152, 6198.318184999736, 6324.557280990287, 6398.424141827258, 6420.454261387647, 6485.156929599122], "value": 5044.119220991693, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [890.5814267294373, 894.9373543851931, 920.236203950721, 922.0641049334922, 931.2782593490044, 17193.312267509285, 17527.73708394372, 17624.82375176248, 17631.38290159843, 17632.11839408031, 17556.648867022654, 17903.64192716145, 17910.910445447786, 17977.640447191083, 17994.730079048826, 967.9564419601135, 968.6851773173712, 971.9562619682131, 972.533184071646, 972.7519482531944, 953.909378609031, 955.2262667239523, 956.5599824080931, 956.8325543029977, 973.9269554783384, 995.6664517386648, 1011.7420057885229, 1011.9392836429838, 1018.5416562546847, 1031.417249254169, 994.3288280410694, 999.0309399882175, 1010.5957616953204, 1011.4487604255662, 1027.3014350241833, 725.5284065357507, 741.1735914455397, 744.0699126092385, 748.7005197920821, 749.6401727170934, 18817.717734233996, 18854.905725471286, 18933.905330473397, 18974.14616342254, 18991.33530326446, 20809.37571872846, 20825.479363015893, 21093.47266318339, 21302.254421095342, 21338.57322853534, 16139.273732682057, 16562.917185413997, 16673.91663041689, 17129.314827406888, 17321.566960825956, 3622.9131260621707, 3673.155174309897, 3678.0988657779017, 3680.263947210542, 3681.4293784463453, 103715.0, 123353.0, 135493.999999999, 137418.31290843582, 139826.0, 17069.40257090996, 17260.136993150543, 17338.30646774115, 17418.042007689444, 17456.91271543634, 29351.853240734086, 29659.85170074179, 29936.251593709894, 29955.400891982037, 30109.849450752605, 9170.95414522923, 9172.082791720775, 9175.541222938826, 9186.632534698538, 9198.816023679623, 3916.3342231820657, 3930.9213815723524, 3965.8017099145504, 4048.3927410888014, 4054.71616986814, 4982.90034199314, 5119.1553393690365, 5133.204353325241, 5133.922991155136, 5164.7934082636275, 995.5719040812376, 1036.186593524095, 1039.5322105052755, 1048.4548035021899, 1055.0609957138154, 683.3200965039717, 700.3206889317354, 703.3002162848, 707.5153519838824, 716.0869890889054, 11623.941880290544, 12014.0, 12328.50685972551, 13031.15297505678, 13238.338083096, 672.0, 676.5636164673856, 682.310866025318, 691.339770519163, 696.0742212856889, 5559.305086864142, 5572.832815015556, 5595.18869763882, 5596.552275817925, 5696.544276457874, 119566.0, 120791.0, 122912.0, 125524.0, 128637.35681321533, 105166.0, 106896.0, 107289.46355268174, 110166.0, 110576.0, 94961.0, 96206.11381658421, 100518.49740751396, 100778.0, 100928.49535752274, 10503.789924201626, 10530.894691052992, 10534.051935325857, 10536.420496872746, 10612.310199837295, 43313.0, 43850.561494384645, 44120.55879441164, 44704.10591788211, 45073.77463112663, 57325.0, 57408.42591574031, 58032.70983645055, 58518.0, 59741.402585975324, 15653.921730391276, 16050.919745401197, 16138.515844524683, 16224.513264602081, 16316.265768040705, 17379.913100434922, 17483.56291092733, 17572.82427175712, 17655.823441765417, 17847.46457606274, 15798.289076991334, 15814.0, 15831.050136991817, 15916.0, 16085.115318657587, 15440.691186176438, 15452.613684657974, 15611.765823512429, 15793.842061579237, 15805.762913556537, 15595.922020389826, 15757.763633545277, 15790.368385264921, 15933.36266549325, 15938.203089845692, 10146.898531014891, 10226.13077888358, 10261.076503114755, 10360.0, 10372.27394082407, 11474.565679290088, 11528.250663706833, 11530.538778448768, 11819.763604728028, 11952.223105498115], "value": 8801.688586241717, "unit": "score"}]}, {"extraOptions": ["e10s", "stylo_disabled"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1428.4999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 110.0, 109.0, 107.0, 110.0, 108.0, 114.0, 109.0, 113.0, 108.0], "value": 109.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 120.0, 116.0, 119.0, 118.0, 117.0, 117.0, 119.0, 148.0, 121.0], "value": 121.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 162.0, 162.0, 165.0, 163.0, 164.0, 172.0, 170.0, 165.0, 164.0], "value": 165.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 72.0, 73.0, 73.0, 74.0, 73.0, 76.0, 77.0, 79.0], "value": 75.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 79.0, 81.0, 82.0, 79.0, 80.0, 79.0, 79.0, 80.0, 79.0], "value": 79.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 110.0, 114.0, 113.0, 113.0, 113.0, 114.0, 115.0, 116.0, 117.0], "value": 113.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 148.0, 150.0, 150.0, 150.0, 148.0, 148.0, 148.0, 148.0, 148.0], "value": 148.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 94.0, 95.0, 94.0, 94.0, 95.0, 94.0, 94.0, 94.0, 94.0], "value": 94.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 57.0, 57.0, 55.0, 53.0, 55.0, 55.0, 53.0, 54.0, 54.0], "value": 54.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [38.0, 38.0, 38.0, 38.0, 38.0, 38.0, 37.0, 38.0, 38.0, 38.0], "value": 37.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 77.0, 75.0, 76.0, 75.0, 75.0, 75.0, 74.0, 75.0, 75.0], "value": 75.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 118.0, 118.0, 116.0, 112.0, 118.0, 113.0, 120.0, 116.0, 112.0], "value": 115.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 169.0, 170.0, 168.0, 168.0, 174.0, 170.0, 168.0, 166.0, 171.0], "value": 169.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 70.0, 74.0, 70.0, 64.0, 66.0, 65.0, 66.0, 67.0, 65.0], "value": 67.4, "unit": "score"}]}]} 05:39:58 INFO - Return code: 0 05:39:58 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:39:58 INFO - # TBPL SUCCESS # 05:39:58 INFO - Running post-action listener: _package_coverage_data 05:39:58 INFO - Running post-action listener: _resource_record_post_action 05:39:58 INFO - [mozharness: 2017-09-13 12:39:58.583919Z] Finished run-tests step (success) 05:39:58 INFO - Running post-run listener: _resource_record_post_run 05:39:58 INFO - Total resource usage - Wall time: 1187s; CPU: 13.0%; Read bytes: 4096; Write bytes: 345751552; Read time: 8; Write time: 221128 05:39:58 INFO - TinderboxPrint: CPU usage
13.1% 05:39:58 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 05:39:58 INFO - TinderboxPrint: I/O write bytes / time
345,751,552 / 221,128 05:39:58 INFO - TinderboxPrint: CPU idle
8,217.7 (86.8%) 05:39:58 INFO - TinderboxPrint: CPU user
1,194.7 (12.6%) 05:39:58 INFO - TinderboxPrint: Swap in / out
0 / 0 05:39:58 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 13078528; Read time: 0; Write time: 2532 05:39:58 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 05:39:58 INFO - run-tests - Wall time: 1169s; CPU: 13.0%; Read bytes: 0; Write bytes: 332673024; Read time: 0; Write time: 218596 05:39:59 INFO - Running post-run listener: _upload_blobber_files 05:39:59 INFO - Blob upload gear active. 05:39:59 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:39:59 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 05:39:59 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'] 05:39:59 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 05:39:59 INFO - (blobuploader) - INFO - Open directory for files ... 05:39:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 05:39:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:39:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:40:00 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 05:40:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:40:00 INFO - (blobuploader) - INFO - Done attempting. 05:40:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:40:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:40:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:40:06 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:40:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:40:06 INFO - (blobuploader) - INFO - Done attempting. 05:40:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log ... 05:40:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:40:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:40:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_errorsummary.log: uploaded 05:40:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:40:07 INFO - (blobuploader) - INFO - Done attempting. 05:40:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log ... 05:40:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:40:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:40:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_raw.log: uploaded 05:40:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:40:08 INFO - (blobuploader) - INFO - Done attempting. 05:40:08 INFO - (blobuploader) - INFO - Iteration through files over. 05:40:08 INFO - Return code: 0 05:40:08 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:40:08 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:40:08 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c713bbf671b34e37decefab1108013cd9999c4d67555fb7f74417fad4d8a32d8c0863b45aa04ccc70fa72d20a8353d924cebb57850d7a31a4cbe2726b7ae2a29", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d7567e5c640783ee23253f6e179acaa32a4cb9f8e3fae2398da4002e3868f8edffc6e0aa25e4739b84e79b57408d6d14b3b4493759014fdfc33818fd50b962d2", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a15682a6d1797fb318e603b002dfb64c64de830a568c46740477051ca55b59daf2306faf8e06acf789b20388e8ff3a293e290ec1c5fc6c4822e5bfa1f3ee3310", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8135cbf17f4fbdb4e894370e9d5eda6a3fc739c449f6aae2c0b165d14d6db354c8e92de9dd91f8365c29a6c7527b38e71f3c981df7d30523361a30b88e0be6c8"} 05:40:08 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:40:08 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:40:08 INFO - Contents: 05:40:08 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c713bbf671b34e37decefab1108013cd9999c4d67555fb7f74417fad4d8a32d8c0863b45aa04ccc70fa72d20a8353d924cebb57850d7a31a4cbe2726b7ae2a29", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d7567e5c640783ee23253f6e179acaa32a4cb9f8e3fae2398da4002e3868f8edffc6e0aa25e4739b84e79b57408d6d14b3b4493759014fdfc33818fd50b962d2", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a15682a6d1797fb318e603b002dfb64c64de830a568c46740477051ca55b59daf2306faf8e06acf789b20388e8ff3a293e290ec1c5fc6c4822e5bfa1f3ee3310", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8135cbf17f4fbdb4e894370e9d5eda6a3fc739c449f6aae2c0b165d14d6db354c8e92de9dd91f8365c29a6c7527b38e71f3c981df7d30523361a30b88e0be6c8"} 05:40:08 INFO - Running post-run listener: copy_logs_to_upload_dir 05:40:08 INFO - Copying logs to upload dir... 05:40:08 INFO - mkdir: /builds/slave/test/build/upload/logs 05:40:08 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1237.275744 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2017-09-13 05:40:08.782897) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-13 05:40:08.786590) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1505300237.672302-631552636 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/c713bbf671b34e37decefab1108013cd9999c4d67555fb7f74417fad4d8a32d8c0863b45aa04ccc70fa72d20a8353d924cebb57850d7a31a4cbe2726b7ae2a29", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d7567e5c640783ee23253f6e179acaa32a4cb9f8e3fae2398da4002e3868f8edffc6e0aa25e4739b84e79b57408d6d14b3b4493759014fdfc33818fd50b962d2", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a15682a6d1797fb318e603b002dfb64c64de830a568c46740477051ca55b59daf2306faf8e06acf789b20388e8ff3a293e290ec1c5fc6c4822e5bfa1f3ee3310", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8135cbf17f4fbdb4e894370e9d5eda6a3fc739c449f6aae2c0b165d14d6db354c8e92de9dd91f8365c29a6c7527b38e71f3c981df7d30523361a30b88e0be6c8"} build_url:https://queue.taskcluster.net/v1/task/DkoRCDt5TmCGOf_xf-Pg9A/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011446 build_url: 'https://queue.taskcluster.net/v1/task/DkoRCDt5TmCGOf_xf-Pg9A/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c713bbf671b34e37decefab1108013cd9999c4d67555fb7f74417fad4d8a32d8c0863b45aa04ccc70fa72d20a8353d924cebb57850d7a31a4cbe2726b7ae2a29", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d7567e5c640783ee23253f6e179acaa32a4cb9f8e3fae2398da4002e3868f8edffc6e0aa25e4739b84e79b57408d6d14b3b4493759014fdfc33818fd50b962d2", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a15682a6d1797fb318e603b002dfb64c64de830a568c46740477051ca55b59daf2306faf8e06acf789b20388e8ff3a293e290ec1c5fc6c4822e5bfa1f3ee3310", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8135cbf17f4fbdb4e894370e9d5eda6a3fc739c449f6aae2c0b165d14d6db354c8e92de9dd91f8365c29a6c7527b38e71f3c981df7d30523361a30b88e0be6c8"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-13 05:40:08.815302) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-13 05:40:08.815650) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1505300237.672302-631552636 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004467 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-13 05:40:08.900816) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-13 05:40:08.901188) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-13 05:40:08.901537) ========= ========= Total master_lag: 0.21 =========