builder: mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s slave: talos-linux64-ix-082 starttime: 1505730024.95 results: success (0) revision: 4ef69bbd6816d95ade430640785971f587e2d5bc ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-18 03:20:24.946252) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-18 03:20:24.946688) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-18 03:20:24.950733) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-18 03:20:25.051668) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-18 03:20:25.052038) ========= 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=51fc86400edbde9650d2781a000001d0-1505728357.689909-1513033008 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-18 03:20:24-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 223M=0s 2017-09-18 03:20:25 (223 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.141594 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-18 03:20:25.229857) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-18 03:20:25.230341) ========= 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=51fc86400edbde9650d2781a000001d0-1505728357.689909-1513033008 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018739 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-18 03:20:25.295752) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 13 secs) (at 2017-09-18 03:20:25.296144) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 4ef69bbd6816d95ade430640785971f587e2d5bc --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 4ef69bbd6816d95ade430640785971f587e2d5bc --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=51fc86400edbde9650d2781a000001d0-1505728357.689909-1513033008 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-18 03:20:25,269 truncating revision to first 12 chars 2017-09-18 03:20:25,269 Setting DEBUG logging. 2017-09-18 03:20:25,269 attempt 1/10 2017-09-18 03:20:25,269 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/4ef69bbd6816?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-18 03:20:25,887 sleeping for 11.00s (attempt 1/10) 2017-09-18 03:20:36,898 attempt 2/10 2017-09-18 03:20:36,899 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/4ef69bbd6816?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-18 03:20:38,099 unpacking tar archive at: mozilla-central-4ef69bbd6816/testing/mozharness/ program finished with exit code 0 elapsedTime=13.118094 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 13 secs) (at 2017-09-18 03:20:38.435022) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-18 03:20:38.435351) ========= script_repo_revision: 4ef69bbd6816d95ade430640785971f587e2d5bc ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-18 03:20:38.435675) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-18 03:20:38.435929) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-18 03:20:38.454184) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2017-09-18 03:20:38.454446) ========= /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=51fc86400edbde9650d2781a000001d0-1505728357.689909-1513033008 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:20:38 INFO - MultiFileLogger online at 20170918 03:20:38 in /builds/slave/test 03:20:38 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 03:20:38 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:20:38 INFO - {'append_to_log': False, 03:20:38 INFO - 'base_work_dir': '/builds/slave/test', 03:20:38 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 03:20:38 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:20:38 INFO - 'branch': 'Firefox-Non-PGO', 03:20:38 INFO - 'buildbot_json_path': 'buildprops.json', 03:20:38 INFO - 'code_coverage': False, 03:20:38 INFO - 'config_files': ('talos/linux_config.py',), 03:20:38 INFO - 'default_actions': ('clobber', 03:20:38 INFO - 'read-buildbot-config', 03:20:38 INFO - 'download-and-extract', 03:20:38 INFO - 'populate-webroot', 03:20:38 INFO - 'create-virtualenv', 03:20:38 INFO - 'install', 03:20:38 INFO - 'setup-mitmproxy', 03:20:38 INFO - 'run-tests'), 03:20:38 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:20:38 INFO - 'disable_ccov_upload': False, 03:20:38 INFO - 'disable_stylo': False, 03:20:38 INFO - 'download_minidump_stackwalk': True, 03:20:38 INFO - 'download_symbols': 'ondemand', 03:20:38 INFO - 'enable_stylo': False, 03:20:38 INFO - 'enable_webrender': False, 03:20:38 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 03:20:38 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:20:38 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:20:38 INFO - 'gecko_profile': False, 03:20:38 INFO - 'gecko_profile_interval': 0, 03:20:38 INFO - 'installer_path': 'installer.exe', 03:20:38 INFO - 'log_level': 'info', 03:20:38 INFO - 'log_name': 'talos', 03:20:38 INFO - 'log_to_console': True, 03:20:38 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:20:38 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:20:38 INFO - 'opt_config_files': (), 03:20:38 INFO - 'pip_index': False, 03:20:38 INFO - 'suite': 'dromaeojs-stylo-disabled-e10s', 03:20:38 INFO - 'system_bits': '32', 03:20:38 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:20:38 INFO - 'title': 'talos-linux64-ix-082', 03:20:38 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:20:38 INFO - 'use_talos_json': True, 03:20:38 INFO - 'verify': 'False', 03:20:38 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:20:38 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:20:38 INFO - 'work_dir': 'build'} 03:20:38 INFO - [mozharness: 2017-09-18 10:20:38.560769Z] Running clobber step. 03:20:38 INFO - Running pre-action listener: _resource_record_pre_action 03:20:38 INFO - Running main action method: clobber 03:20:38 INFO - rmtree: /builds/slave/test/build 03:20:38 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:20:40 INFO - Running post-action listener: _resource_record_post_action 03:20:40 INFO - [mozharness: 2017-09-18 10:20:40.076934Z] Finished clobber step (success) 03:20:40 INFO - [mozharness: 2017-09-18 10:20:40.077032Z] Running read-buildbot-config step. 03:20:40 INFO - Running pre-action listener: _resource_record_pre_action 03:20:40 INFO - Running main action method: read_buildbot_config 03:20:40 INFO - Using buildbot properties: 03:20:40 INFO - { 03:20:40 INFO - "project": "", 03:20:40 INFO - "product": "firefox", 03:20:40 INFO - "who": "archaeopteryx@coole-files.de", 03:20:40 INFO - "installer_path": "public/build/target.tar.bz2", 03:20:40 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s", 03:20:40 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 03:20:40 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-stylo-disabled-e10s", 03:20:40 INFO - "stage_platform": "linux64", 03:20:40 INFO - "basedir": "/builds/slave/test", 03:20:40 INFO - "buildnumber": 37, 03:20:40 INFO - "platform": "ubuntu64_hw", 03:20:40 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 03:20:40 INFO - "slavebuilddir": "test", 03:20:40 INFO - "taskId": "JLtsj5hdRtO6eGNdjDtPDQ", 03:20:40 INFO - "branch": "mozilla-central", 03:20:40 INFO - "script_repo_revision": "production", 03:20:40 INFO - "revision": "4ef69bbd6816d95ade430640785971f587e2d5bc", 03:20:40 INFO - "slavename": "talos-linux64-ix-082", 03:20:40 INFO - "repo_path": "mozilla-central" 03:20:40 INFO - } 03:20:40 INFO - Finding installer, test and symbols from parent task. 03:20:40 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JLtsj5hdRtO6eGNdjDtPDQ'}, attempt #1 03:20:40 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JLtsj5hdRtO6eGNdjDtPDQ'}, attempt #1 03:20:40 INFO - Task dependencies: WN7zCNJvSaqvgRuYr4ZXkw 03:20:40 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WN7zCNJvSaqvgRuYr4ZXkw'}, attempt #1 03:20:41 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/WN7zCNJvSaqvgRuYr4ZXkw/artifacts/public/build/target.tar.bz2 03:20:41 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/WN7zCNJvSaqvgRuYr4ZXkw/artifacts/public/build/target.test_packages.json 03:20:41 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/WN7zCNJvSaqvgRuYr4ZXkw/artifacts/public/build/target.crashreporter-symbols.zip 03:20:41 INFO - Running post-action listener: _resource_record_post_action 03:20:41 INFO - [mozharness: 2017-09-18 10:20:41.444713Z] Finished read-buildbot-config step (success) 03:20:41 INFO - [mozharness: 2017-09-18 10:20:41.444932Z] Running download-and-extract step. 03:20:41 INFO - Running pre-action listener: _resource_record_pre_action 03:20:41 INFO - Running main action method: download_and_extract 03:20:41 INFO - mkdir: /builds/slave/test/build/tests 03:20:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:20:41 INFO - trying https://queue.taskcluster.net/v1/task/WN7zCNJvSaqvgRuYr4ZXkw/artifacts/public/build/target.test_packages.json 03:20:41 INFO - Downloading https://queue.taskcluster.net/v1/task/WN7zCNJvSaqvgRuYr4ZXkw/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 03:20:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WN7zCNJvSaqvgRuYr4ZXkw/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 03:20:41 INFO - Downloaded 989 bytes. 03:20:41 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 03:20:41 INFO - Using the following test package requirements: 03:20:41 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 03:20:41 INFO - u'common': [u'target.common.tests.zip'], 03:20:41 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 03:20:41 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 03:20:41 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 03:20:41 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 03:20:41 INFO - u'mozbase': [u'target.common.tests.zip'], 03:20:41 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 03:20:41 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 03:20:41 INFO - u'web-platform': [u'target.common.tests.zip', 03:20:41 INFO - u'target.web-platform.tests.tar.gz'], 03:20:41 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 03:20:41 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 03:20:41 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/WN7zCNJvSaqvgRuYr4ZXkw/artifacts/public/build/target.common.tests.zip 03:20:41 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/WN7zCNJvSaqvgRuYr4ZXkw/artifacts/public/build/target.common.tests.zip'}, attempt #1 03:20:41 INFO - Fetch https://queue.taskcluster.net/v1/task/WN7zCNJvSaqvgRuYr4ZXkw/artifacts/public/build/target.common.tests.zip into memory 03:20:43 INFO - Content-Length response header: 54731157 03:20:43 INFO - Bytes received: 54731157 03:20:53 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/WN7zCNJvSaqvgRuYr4ZXkw/artifacts/public/build/target.talos.tests.zip 03:20:53 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/WN7zCNJvSaqvgRuYr4ZXkw/artifacts/public/build/target.talos.tests.zip'}, attempt #1 03:20:53 INFO - Fetch https://queue.taskcluster.net/v1/task/WN7zCNJvSaqvgRuYr4ZXkw/artifacts/public/build/target.talos.tests.zip into memory 03:20:54 INFO - Content-Length response header: 14508748 03:20:54 INFO - Bytes received: 14508748 03:20:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:20:54 INFO - trying https://queue.taskcluster.net/v1/task/WN7zCNJvSaqvgRuYr4ZXkw/artifacts/public/build/target.tar.bz2 03:20:54 INFO - Downloading https://queue.taskcluster.net/v1/task/WN7zCNJvSaqvgRuYr4ZXkw/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 03:20:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WN7zCNJvSaqvgRuYr4ZXkw/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 03:20:56 INFO - Downloaded 61444184 bytes. 03:20:56 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/WN7zCNJvSaqvgRuYr4ZXkw/artifacts/public/build/target.tar.bz2 03:20:56 INFO - mkdir: /builds/slave/test/properties 03:20:56 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:20:56 INFO - Writing to file /builds/slave/test/properties/build_url 03:20:56 INFO - Contents: 03:20:56 INFO - build_url:https://queue.taskcluster.net/v1/task/WN7zCNJvSaqvgRuYr4ZXkw/artifacts/public/build/target.tar.bz2 03:20:56 INFO - Running post-action listener: _resource_record_post_action 03:20:56 INFO - Running post-action listener: find_tests_for_verification 03:20:56 INFO - Running post-action listener: set_extra_try_arguments 03:20:56 INFO - [mozharness: 2017-09-18 10:20:56.577660Z] Finished download-and-extract step (success) 03:20:56 INFO - [mozharness: 2017-09-18 10:20:56.577892Z] Running populate-webroot step. 03:20:56 INFO - Running pre-action listener: _resource_record_pre_action 03:20:56 INFO - Running main action method: populate_webroot 03:20:56 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:20:56 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:20:56 INFO - 'tests': ['tresize', 03:20:56 INFO - 'tcanvasmark']}, 03:20:56 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:20:56 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:20:56 INFO - 'tests': ['dromaeo_css', 03:20:56 INFO - 'kraken']}, 03:20:56 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 03:20:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:20:56 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:20:56 INFO - 'talos_options': ['--disable-stylo'], 03:20:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:20:56 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 03:20:56 INFO - 'tests': ['damp', 'tps']}, 03:20:56 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:20:56 INFO - 'talos_options': ['--disable-stylo'], 03:20:56 INFO - 'tests': ['damp', 'tps']}, 03:20:56 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:20:56 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:20:56 INFO - 'tests': ['dromaeo_dom']}, 03:20:56 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 03:20:56 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:20:56 INFO - 'tests': ['basic_compositor_video', 03:20:56 INFO - 'glvideo']}, 03:20:56 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 03:20:56 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 03:20:56 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:20:56 INFO - 'talos_options': ['--disable-stylo'], 03:20:56 INFO - 'tests': ['ts_paint_webext', 03:20:56 INFO - 'tp5o_webext']}, 03:20:56 INFO - 'other-e10s': {'tests': ['a11yr', 03:20:56 INFO - 'ts_paint', 03:20:56 INFO - 'tpaint', 03:20:56 INFO - 'sessionrestore', 03:20:56 INFO - 'sessionrestore_many_windows', 03:20:56 INFO - 'sessionrestore_no_auto_restore', 03:20:56 INFO - 'tabpaint']}, 03:20:56 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:20:56 INFO - 'tests': ['a11yr', 03:20:56 INFO - 'ts_paint', 03:20:56 INFO - 'tpaint', 03:20:56 INFO - 'sessionrestore', 03:20:56 INFO - 'sessionrestore_many_windows', 03:20:56 INFO - 'sessionrestore_no_auto_restore', 03:20:56 INFO - 'tabpaint']}, 03:20:56 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 03:20:56 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 03:20:56 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:20:56 INFO - 'tests': ['perf_reftest_singletons']}, 03:20:56 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:20:56 INFO - 'tests': ['bloom_basic']}, 03:20:56 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:20:56 INFO - 'tsvgr_opacity', 03:20:56 INFO - 'tart', 03:20:56 INFO - 'tscrollx', 03:20:56 INFO - 'tsvg_static']}, 03:20:56 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:20:56 INFO - 'tests': ['tsvgx', 03:20:56 INFO - 'tsvgr_opacity', 03:20:56 INFO - 'tart', 03:20:56 INFO - 'tscrollx', 03:20:56 INFO - 'tsvg_static']}, 03:20:56 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 03:20:56 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:20:56 INFO - 'talos_options': ['--disable-stylo'], 03:20:56 INFO - 'tests': ['tp5o']}, 03:20:56 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:20:56 INFO - 'talos_options': ['--mitmproxy', 03:20:56 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:20:56 INFO - '--firstNonBlankPaint'], 03:20:56 INFO - 'tests': ['tp6_google', 03:20:56 INFO - 'tp6_youtube', 03:20:56 INFO - 'tp6_amazon', 03:20:56 INFO - 'tp6_facebook']}, 03:20:56 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:20:56 INFO - 'talos_options': ['--disable-stylo', 03:20:56 INFO - '--mitmproxy', 03:20:56 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:20:56 INFO - '--firstNonBlankPaint'], 03:20:56 INFO - 'tests': ['tp6_google', 03:20:56 INFO - 'tp6_youtube', 03:20:56 INFO - 'tp6_amazon', 03:20:56 INFO - 'tp6_facebook']}, 03:20:56 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:20:56 INFO - 'talos_options': ['--stylo-threads=1', 03:20:56 INFO - '--mitmproxy', 03:20:56 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:20:56 INFO - '--firstNonBlankPaint'], 03:20:56 INFO - 'tests': ['tp6_google', 03:20:56 INFO - 'tp6_youtube', 03:20:56 INFO - 'tp6_amazon', 03:20:56 INFO - 'tp6_facebook']}, 03:20:56 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 03:20:56 INFO - 'talos_options': ['--xperf_path', 03:20:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:20:56 INFO - 'tests': ['tp5n']}, 03:20:56 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:20:56 INFO - 'talos_options': ['--disable-stylo', 03:20:56 INFO - '--xperf_path', 03:20:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:20:56 INFO - 'tests': ['tp5n']}}} 03:20:56 INFO - Running post-action listener: _resource_record_post_action 03:20:56 INFO - [mozharness: 2017-09-18 10:20:56.600353Z] Finished populate-webroot step (success) 03:20:56 INFO - [mozharness: 2017-09-18 10:20:56.600445Z] Running create-virtualenv step. 03:20:56 INFO - Running pre-action listener: _resource_record_pre_action 03:20:56 INFO - Running main action method: create_virtualenv 03:20:56 INFO - Creating virtualenv /builds/slave/test/build/venv 03:20:56 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 03:20:56 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 03:20:56 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 03:20:56 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:20:56 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:20:57 INFO - Installing distribute.............................................................................................................................................................................................done. 03:20:57 INFO - Installing pip...............done. 03:20:57 INFO - Return code: 0 03:20:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 03:20:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 03:20:57 INFO - Reading from file tmpfile_stdout 03:20:57 INFO - Output received: 03:20:57 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 03:20:57 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:20:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:20:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:20:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:20:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:20:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cef1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eb8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x205ba60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x205f090>, '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 0x205fd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2059f90>, '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': '51fc86400edbde9650d2781a000001d0-1505728357.689909-1513033008', '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 03:20:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 03:20:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 03:20:57 INFO - Using env: {'DISPLAY': ':0', 03:20:57 INFO - 'HOME': '/home/cltbld', 03:20:57 INFO - 'LANG': 'en_US.UTF-8', 03:20:57 INFO - 'LANGUAGE': 'en_US:en', 03:20:57 INFO - 'LOGNAME': 'cltbld', 03:20:57 INFO - 'MAIL': '/var/mail/cltbld', 03:20:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:20:57 INFO - 'MOZ_NO_REMOTE': '1', 03:20:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:20:57 INFO - 'NO_EM_RESTART': '1', 03:20:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:20:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:20:57 INFO - 'PWD': '/builds/slave/test', 03:20:57 INFO - 'SHELL': '/bin/bash', 03:20:57 INFO - 'SHLVL': '1', 03:20:57 INFO - 'TERM': 'linux', 03:20:57 INFO - 'TMOUT': '86400', 03:20:57 INFO - 'USER': 'cltbld', 03:20:57 INFO - 'XDG_SESSION_COOKIE': '51fc86400edbde9650d2781a000001d0-1505728357.689909-1513033008', 03:20:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:20:57 INFO - '_': '/tools/buildbot/bin/python'} 03:20:58 INFO - Ignoring indexes: http://pypi.python.org/simple/ 03:20:58 INFO - Downloading/unpacking pip>=1.5 03:20:58 INFO - Running setup.py egg_info for package pip 03:20:58 INFO - warning: no files found matching 'pip/cacert.pem' 03:20:58 INFO - warning: no files found matching '*.html' under directory 'docs' 03:20:58 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 03:20:58 INFO - no previously-included directories found matching 'docs/_build/_sources' 03:20:58 INFO - Installing collected packages: pip 03:20:58 INFO - Found existing installation: pip 1.1 03:20:58 INFO - Uninstalling pip: 03:20:58 INFO - Successfully uninstalled pip 03:20:58 INFO - Running setup.py install for pip 03:20:58 INFO - warning: no files found matching 'pip/cacert.pem' 03:20:58 INFO - warning: no files found matching '*.html' under directory 'docs' 03:20:58 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 03:20:58 INFO - no previously-included directories found matching 'docs/_build/_sources' 03:20:58 INFO - Installing pip script to /builds/slave/test/build/venv/bin 03:20:58 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 03:20:58 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 03:20:58 INFO - Successfully installed pip 03:20:58 INFO - Cleaning up... 03:20:58 INFO - Return code: 0 03:20:58 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:20: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')]} 03:20:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:20: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')]} 03:20:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:20: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', '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 0x1cef1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eb8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x205ba60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x205f090>, '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 0x205fd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2059f90>, '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': '51fc86400edbde9650d2781a000001d0-1505728357.689909-1513033008', '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 03:20: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', 'psutil>=3.1.1'] in /builds/slave/test/build 03:20: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 psutil>=3.1.1 03:20:58 INFO - Using env: {'DISPLAY': ':0', 03:20:58 INFO - 'HOME': '/home/cltbld', 03:20:58 INFO - 'LANG': 'en_US.UTF-8', 03:20:58 INFO - 'LANGUAGE': 'en_US:en', 03:20:58 INFO - 'LOGNAME': 'cltbld', 03:20:58 INFO - 'MAIL': '/var/mail/cltbld', 03:20:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:20:58 INFO - 'MOZ_NO_REMOTE': '1', 03:20:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:20:58 INFO - 'NO_EM_RESTART': '1', 03:20:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:20:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:20:58 INFO - 'PWD': '/builds/slave/test', 03:20:58 INFO - 'SHELL': '/bin/bash', 03:20:58 INFO - 'SHLVL': '1', 03:20:58 INFO - 'TERM': 'linux', 03:20:58 INFO - 'TMOUT': '86400', 03:20:58 INFO - 'USER': 'cltbld', 03:20:58 INFO - 'XDG_SESSION_COOKIE': '51fc86400edbde9650d2781a000001d0-1505728357.689909-1513033008', 03:20:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:20:58 INFO - '_': '/tools/buildbot/bin/python'} 03:20:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:20:59 INFO - Downloading/unpacking psutil>=3.1.1 03:20: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 03:20: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 03:20: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 03:20: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 03:21:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:21:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:21:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:21:00 INFO - Installing collected packages: psutil 03:21:00 INFO - Running setup.py install for psutil 03:21:00 INFO - building 'psutil._psutil_linux' extension 03:21:00 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 03:21:00 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 03:21:00 INFO - building 'psutil._psutil_posix' extension 03:21:00 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 03:21:00 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 03:21:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:21:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:21:00 INFO - Successfully installed psutil 03:21:00 INFO - Cleaning up... 03:21:00 INFO - Return code: 0 03:21:00 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:21:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:21:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:21:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:21:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:21:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cef1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eb8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x205ba60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x205f090>, '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 0x205fd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2059f90>, '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': '51fc86400edbde9650d2781a000001d0-1505728357.689909-1513033008', '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 03:21:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 03:21:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 03:21:00 INFO - Using env: {'DISPLAY': ':0', 03:21:00 INFO - 'HOME': '/home/cltbld', 03:21:00 INFO - 'LANG': 'en_US.UTF-8', 03:21:00 INFO - 'LANGUAGE': 'en_US:en', 03:21:00 INFO - 'LOGNAME': 'cltbld', 03:21:00 INFO - 'MAIL': '/var/mail/cltbld', 03:21:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:21:00 INFO - 'MOZ_NO_REMOTE': '1', 03:21:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:21:00 INFO - 'NO_EM_RESTART': '1', 03:21:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:21:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:21:00 INFO - 'PWD': '/builds/slave/test', 03:21:00 INFO - 'SHELL': '/bin/bash', 03:21:00 INFO - 'SHLVL': '1', 03:21:00 INFO - 'TERM': 'linux', 03:21:00 INFO - 'TMOUT': '86400', 03:21:00 INFO - 'USER': 'cltbld', 03:21:00 INFO - 'XDG_SESSION_COOKIE': '51fc86400edbde9650d2781a000001d0-1505728357.689909-1513033008', 03:21:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:21:00 INFO - '_': '/tools/buildbot/bin/python'} 03:21:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:21:01 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:21: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 03:21: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 03:21: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 03:21: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 03:21:02 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:21:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:21:02 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:21:02 INFO - Installing collected packages: mozsystemmonitor 03:21:02 INFO - Running setup.py install for mozsystemmonitor 03:21:02 INFO - Successfully installed mozsystemmonitor 03:21:02 INFO - Cleaning up... 03:21:02 INFO - Return code: 0 03:21:02 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:21:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:21:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:21:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:21:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:21:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cef1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eb8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x205ba60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x205f090>, '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 0x205fd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2059f90>, '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': '51fc86400edbde9650d2781a000001d0-1505728357.689909-1513033008', '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 03:21:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 03:21:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 03:21:02 INFO - Using env: {'DISPLAY': ':0', 03:21:02 INFO - 'HOME': '/home/cltbld', 03:21:02 INFO - 'LANG': 'en_US.UTF-8', 03:21:02 INFO - 'LANGUAGE': 'en_US:en', 03:21:02 INFO - 'LOGNAME': 'cltbld', 03:21:02 INFO - 'MAIL': '/var/mail/cltbld', 03:21:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:21:02 INFO - 'MOZ_NO_REMOTE': '1', 03:21:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:21:02 INFO - 'NO_EM_RESTART': '1', 03:21:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:21:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:21:02 INFO - 'PWD': '/builds/slave/test', 03:21:02 INFO - 'SHELL': '/bin/bash', 03:21:02 INFO - 'SHLVL': '1', 03:21:02 INFO - 'TERM': 'linux', 03:21:02 INFO - 'TMOUT': '86400', 03:21:02 INFO - 'USER': 'cltbld', 03:21:02 INFO - 'XDG_SESSION_COOKIE': '51fc86400edbde9650d2781a000001d0-1505728357.689909-1513033008', 03:21:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:21:02 INFO - '_': '/tools/buildbot/bin/python'} 03:21:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:21:02 INFO - Downloading/unpacking jsonschema==2.5.1 03:21:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:21:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:21:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:21:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:21:04 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:21:04 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:21:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:21:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:21:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:21:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:21:04 INFO - Downloading functools32-3.2.3-2.tar.gz 03:21:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:21:04 INFO - warning: no files found matching '*.txt' 03:21:04 INFO - no previously-included directories found matching 'build' 03:21:04 INFO - no previously-included directories found matching 'dist' 03:21:04 INFO - no previously-included directories found matching '.git*' 03:21:04 INFO - Installing collected packages: jsonschema, functools32 03:21:04 INFO - Running setup.py install for functools32 03:21:04 INFO - warning: no files found matching '*.txt' 03:21:04 INFO - no previously-included directories found matching 'build' 03:21:04 INFO - no previously-included directories found matching 'dist' 03:21:04 INFO - no previously-included directories found matching '.git*' 03:21:04 INFO - Successfully installed jsonschema functools32 03:21:04 INFO - Cleaning up... 03:21:04 INFO - Return code: 0 03:21:04 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:21:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:21:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:21:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:21:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:21:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cef1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eb8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x205ba60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x205f090>, '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 0x205fd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2059f90>, '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': '51fc86400edbde9650d2781a000001d0-1505728357.689909-1513033008', '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 03:21:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 03:21:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 03:21:04 INFO - Using env: {'DISPLAY': ':0', 03:21:04 INFO - 'HOME': '/home/cltbld', 03:21:04 INFO - 'LANG': 'en_US.UTF-8', 03:21:04 INFO - 'LANGUAGE': 'en_US:en', 03:21:04 INFO - 'LOGNAME': 'cltbld', 03:21:04 INFO - 'MAIL': '/var/mail/cltbld', 03:21:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:21:04 INFO - 'MOZ_NO_REMOTE': '1', 03:21:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:21:04 INFO - 'NO_EM_RESTART': '1', 03:21:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:21:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:21:04 INFO - 'PWD': '/builds/slave/test', 03:21:04 INFO - 'SHELL': '/bin/bash', 03:21:04 INFO - 'SHLVL': '1', 03:21:04 INFO - 'TERM': 'linux', 03:21:04 INFO - 'TMOUT': '86400', 03:21:04 INFO - 'USER': 'cltbld', 03:21:04 INFO - 'XDG_SESSION_COOKIE': '51fc86400edbde9650d2781a000001d0-1505728357.689909-1513033008', 03:21:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:21:04 INFO - '_': '/tools/buildbot/bin/python'} 03:21:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:21:04 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:21:04 INFO - Cleaning up... 03:21:04 INFO - Return code: 0 03:21:04 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:21:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:21:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:21:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:21:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:21:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cef1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eb8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x205ba60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x205f090>, '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 0x205fd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2059f90>, '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': '51fc86400edbde9650d2781a000001d0-1505728357.689909-1513033008', '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 03:21:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 03:21:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 03:21:04 INFO - Using env: {'DISPLAY': ':0', 03:21:04 INFO - 'HOME': '/home/cltbld', 03:21:04 INFO - 'LANG': 'en_US.UTF-8', 03:21:04 INFO - 'LANGUAGE': 'en_US:en', 03:21:04 INFO - 'LOGNAME': 'cltbld', 03:21:04 INFO - 'MAIL': '/var/mail/cltbld', 03:21:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:21:04 INFO - 'MOZ_NO_REMOTE': '1', 03:21:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:21:04 INFO - 'NO_EM_RESTART': '1', 03:21:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:21:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:21:04 INFO - 'PWD': '/builds/slave/test', 03:21:04 INFO - 'SHELL': '/bin/bash', 03:21:04 INFO - 'SHLVL': '1', 03:21:04 INFO - 'TERM': 'linux', 03:21:04 INFO - 'TMOUT': '86400', 03:21:04 INFO - 'USER': 'cltbld', 03:21:04 INFO - 'XDG_SESSION_COOKIE': '51fc86400edbde9650d2781a000001d0-1505728357.689909-1513033008', 03:21:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:21:04 INFO - '_': '/tools/buildbot/bin/python'} 03:21:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:21:05 INFO - Downloading/unpacking blobuploader==1.2.4 03:21:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:21:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:21:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:21:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:21:06 INFO - Downloading blobuploader-1.2.4.tar.gz 03:21:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:21:06 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:21: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 03:21: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 03:21: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 03:21: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 03:21:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:21:06 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:21: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 03:21: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 03:21: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 03:21: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 03:21:06 INFO - Downloading docopt-0.6.1.tar.gz 03:21:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:21:06 INFO - Installing collected packages: blobuploader, requests, docopt 03:21:06 INFO - Running setup.py install for blobuploader 03:21:06 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:21:06 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:21:06 INFO - Running setup.py install for requests 03:21:07 INFO - Running setup.py install for docopt 03:21:07 INFO - Successfully installed blobuploader requests docopt 03:21:07 INFO - Cleaning up... 03:21:07 INFO - Return code: 0 03:21:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:21:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:21:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:21:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:21:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:21:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cef1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eb8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x205ba60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x205f090>, '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 0x205fd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2059f90>, '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': '51fc86400edbde9650d2781a000001d0-1505728357.689909-1513033008', '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 03:21:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:21:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:21:07 INFO - Using env: {'DISPLAY': ':0', 03:21:07 INFO - 'HOME': '/home/cltbld', 03:21:07 INFO - 'LANG': 'en_US.UTF-8', 03:21:07 INFO - 'LANGUAGE': 'en_US:en', 03:21:07 INFO - 'LOGNAME': 'cltbld', 03:21:07 INFO - 'MAIL': '/var/mail/cltbld', 03:21:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:21:07 INFO - 'MOZ_NO_REMOTE': '1', 03:21:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:21:07 INFO - 'NO_EM_RESTART': '1', 03:21:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:21:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:21:07 INFO - 'PWD': '/builds/slave/test', 03:21:07 INFO - 'SHELL': '/bin/bash', 03:21:07 INFO - 'SHLVL': '1', 03:21:07 INFO - 'TERM': 'linux', 03:21:07 INFO - 'TMOUT': '86400', 03:21:07 INFO - 'USER': 'cltbld', 03:21:07 INFO - 'XDG_SESSION_COOKIE': '51fc86400edbde9650d2781a000001d0-1505728357.689909-1513033008', 03:21:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:21:07 INFO - '_': '/tools/buildbot/bin/python'} 03:21:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:21:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:21:07 INFO - Running setup.py (path:/tmp/pip-y6fe8R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:21:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:21:07 INFO - Running setup.py (path:/tmp/pip-juAZ_2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:21:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:21:07 INFO - Running setup.py (path:/tmp/pip-Yy2PrL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:21:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:21:07 INFO - Running setup.py (path:/tmp/pip-BxgbX6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:21:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:21:07 INFO - Running setup.py (path:/tmp/pip-2DxwRb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:21:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:21:07 INFO - Running setup.py (path:/tmp/pip-iruFVl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:21:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:21:07 INFO - Running setup.py (path:/tmp/pip-VjwM8L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:21:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:21:08 INFO - Running setup.py (path:/tmp/pip-9_L6Pr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:21:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:21:08 INFO - Running setup.py (path:/tmp/pip-EeA4Up-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:21:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:21:08 INFO - Running setup.py (path:/tmp/pip-LRE1Fc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:21:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:21:08 INFO - Running setup.py (path:/tmp/pip-7I9rAl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:21:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:21:08 INFO - Running setup.py (path:/tmp/pip-aL0zmZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:21:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:21:08 INFO - Running setup.py (path:/tmp/pip-QuLGHj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:21:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:21:08 INFO - Running setup.py (path:/tmp/pip-tkT2Kk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:21:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:21:08 INFO - Running setup.py (path:/tmp/pip-RBHKPh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:21:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:21:08 INFO - Running setup.py (path:/tmp/pip-ChbZnb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:21:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:21:08 INFO - Running setup.py (path:/tmp/pip-FQp016-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:21:08 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:21:08 INFO - Running setup.py install for manifestparser 03:21:08 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:21:08 INFO - Running setup.py install for mozcrash 03:21:08 INFO - Running setup.py install for mozdebug 03:21:09 INFO - Running setup.py install for mozdevice 03:21:09 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:21:09 INFO - Running setup.py install for mozfile 03:21:09 INFO - Running setup.py install for mozhttpd 03:21:09 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:21:09 INFO - Running setup.py install for mozinfo 03:21:09 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:21:09 INFO - Running setup.py install for mozInstall 03:21:09 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:21:09 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:21:09 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:21:09 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:21:09 INFO - Running setup.py install for mozleak 03:21:09 INFO - Running setup.py install for mozlog 03:21:09 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:21:09 INFO - Running setup.py install for moznetwork 03:21:09 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:21:09 INFO - Running setup.py install for mozprocess 03:21:09 INFO - Running setup.py install for mozprofile 03:21:10 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:21:10 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:21:10 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:21:10 INFO - Running setup.py install for mozrunner 03:21:10 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:21:10 INFO - Running setup.py install for mozscreenshot 03:21:10 INFO - Running setup.py install for moztest 03:21:10 INFO - Running setup.py install for mozversion 03:21:10 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:21:10 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:21:10 INFO - Cleaning up... 03:21:10 INFO - Return code: 0 03:21:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:21: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')]} 03:21:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:21: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')]} 03:21:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:21:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cef1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eb8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x205ba60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x205f090>, '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 0x205fd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2059f90>, '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': '51fc86400edbde9650d2781a000001d0-1505728357.689909-1513033008', '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 03:21:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:21:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:21:10 INFO - Using env: {'DISPLAY': ':0', 03:21:10 INFO - 'HOME': '/home/cltbld', 03:21:10 INFO - 'LANG': 'en_US.UTF-8', 03:21:10 INFO - 'LANGUAGE': 'en_US:en', 03:21:10 INFO - 'LOGNAME': 'cltbld', 03:21:10 INFO - 'MAIL': '/var/mail/cltbld', 03:21:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:21:10 INFO - 'MOZ_NO_REMOTE': '1', 03:21:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:21:10 INFO - 'NO_EM_RESTART': '1', 03:21:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:21:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:21:10 INFO - 'PWD': '/builds/slave/test', 03:21:10 INFO - 'SHELL': '/bin/bash', 03:21:10 INFO - 'SHLVL': '1', 03:21:10 INFO - 'TERM': 'linux', 03:21:10 INFO - 'TMOUT': '86400', 03:21:10 INFO - 'USER': 'cltbld', 03:21:10 INFO - 'XDG_SESSION_COOKIE': '51fc86400edbde9650d2781a000001d0-1505728357.689909-1513033008', 03:21:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:21:10 INFO - '_': '/tools/buildbot/bin/python'} 03:21:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:21:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:21:10 INFO - Running setup.py (path:/tmp/pip-Zz64GK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:21:10 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 03:21:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:21:10 INFO - Running setup.py (path:/tmp/pip-QH2Gu2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:21:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:21:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:21:10 INFO - Running setup.py (path:/tmp/pip-LnsEpv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:21:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:21:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:21:10 INFO - Running setup.py (path:/tmp/pip-LG3mxh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:21:11 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)) 03:21:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:21:11 INFO - Running setup.py (path:/tmp/pip-ty9CyH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:21:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 03:21:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:21:11 INFO - Running setup.py (path:/tmp/pip-99_iTQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:21:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 03:21:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:21:11 INFO - Running setup.py (path:/tmp/pip-A8tPei-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:21:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.10 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 03:21:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:21:11 INFO - Running setup.py (path:/tmp/pip-u2YSYp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:21:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.13 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 03:21:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:21:11 INFO - Running setup.py (path:/tmp/pip-lzOR2Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:21:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 03:21:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:21:11 INFO - Running setup.py (path:/tmp/pip-Osr40B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:21:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.5 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:21:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:21:11 INFO - Running setup.py (path:/tmp/pip-yIUBp3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:21:11 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 03:21:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:21:11 INFO - Running setup.py (path:/tmp/pip-RX82ro-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:21:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 03:21:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:21:11 INFO - Running setup.py (path:/tmp/pip-gnb8gL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:21:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 03:21:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:21:11 INFO - Running setup.py (path:/tmp/pip-iA5TT8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:21:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 03:21:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:21:11 INFO - Running setup.py (path:/tmp/pip-uZ3N9h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:21:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 03:21:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:21:11 INFO - Running setup.py (path:/tmp/pip-psFp0e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:21:11 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 03:21:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:21:11 INFO - Running setup.py (path:/tmp/pip-zJGp_W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:21:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 03:21:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:21:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:21:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:21:11 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:21:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:21:11 INFO - Requirement already satisfied (use --upgrade to upgrade): requests in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozInstall==1.13->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 03:21:11 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:21:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:21:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:21:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:21:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:21:13 INFO - Downloading blessings-1.6.tar.gz 03:21:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:21:13 INFO - Installing collected packages: blessings 03:21:13 INFO - Running setup.py install for blessings 03:21:13 INFO - Successfully installed blessings 03:21:13 INFO - Cleaning up... 03:21:13 INFO - Return code: 0 03:21:13 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:21:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:21:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:21:13 INFO - Reading from file tmpfile_stdout 03:21:13 INFO - Current package versions: 03:21:13 INFO - argparse == 1.2.1 03:21:13 INFO - blessings == 1.6 03:21:13 INFO - blobuploader == 1.2.4 03:21:13 INFO - docopt == 0.6.1 03:21:13 INFO - functools32 == 3.2.3-2 03:21:13 INFO - jsonschema == 2.5.1 03:21:13 INFO - manifestparser == 1.1 03:21:13 INFO - mozInstall == 1.13 03:21:13 INFO - mozcrash == 1.0 03:21:13 INFO - mozdebug == 0.1 03:21:13 INFO - mozdevice == 0.51 03:21:13 INFO - mozfile == 1.2 03:21:13 INFO - mozhttpd == 0.7 03:21:13 INFO - mozinfo == 0.10 03:21:13 INFO - mozleak == 0.1 03:21:13 INFO - mozlog == 3.5 03:21:13 INFO - moznetwork == 0.27 03:21:13 INFO - mozprocess == 0.25 03:21:13 INFO - mozprofile == 0.28 03:21:13 INFO - mozrunner == 6.13 03:21:13 INFO - mozscreenshot == 0.1 03:21:13 INFO - mozsystemmonitor == 0.3 03:21:13 INFO - moztest == 0.8 03:21:13 INFO - mozversion == 1.4 03:21:13 INFO - psutil == 3.1.1 03:21:13 INFO - requests == 1.2.3 03:21:13 INFO - wsgiref == 0.1.2 03:21:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:21:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:21:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:21:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:21:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:21:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cef1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eb8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x205ba60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x205f090>, '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 0x205fd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2059f90>, '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': '51fc86400edbde9650d2781a000001d0-1505728357.689909-1513033008', '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 03:21:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 03:21:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:21:13 INFO - Using env: {'DISPLAY': ':0', 03:21:13 INFO - 'HOME': '/home/cltbld', 03:21:13 INFO - 'LANG': 'en_US.UTF-8', 03:21:13 INFO - 'LANGUAGE': 'en_US:en', 03:21:13 INFO - 'LOGNAME': 'cltbld', 03:21:13 INFO - 'MAIL': '/var/mail/cltbld', 03:21:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:21:13 INFO - 'MOZ_NO_REMOTE': '1', 03:21:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:21:13 INFO - 'NO_EM_RESTART': '1', 03:21:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:21:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:21:13 INFO - 'PWD': '/builds/slave/test', 03:21:13 INFO - 'SHELL': '/bin/bash', 03:21:13 INFO - 'SHLVL': '1', 03:21:13 INFO - 'TERM': 'linux', 03:21:13 INFO - 'TMOUT': '86400', 03:21:13 INFO - 'USER': 'cltbld', 03:21:13 INFO - 'XDG_SESSION_COOKIE': '51fc86400edbde9650d2781a000001d0-1505728357.689909-1513033008', 03:21:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:21:13 INFO - '_': '/tools/buildbot/bin/python'} 03:21:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:21:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:21:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 03:21:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 03:21:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:21:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 03:21:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 03:21:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 03:21:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 03:21:13 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 03:21:13 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 03:21:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:21:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:21:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:21:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:21:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 03:21:15 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)) 03:21:15 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)) 03:21:15 INFO - Installing collected packages: simplejson 03:21:15 INFO - Running setup.py install for simplejson 03:21:15 INFO - building 'simplejson._speedups' extension 03:21:15 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 03:21:15 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/simplejson/_speedups.o -o build/lib.linux-x86_64-2.7/simplejson/_speedups.so 03:21:16 INFO - Successfully installed simplejson 03:21:16 INFO - Cleaning up... 03:21:16 INFO - Return code: 0 03:21:16 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:21:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:21:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:21:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:21:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:21:16 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 0x1cef1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eb8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x205ba60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x205f090>, '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 0x205fd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2059f90>, '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': '51fc86400edbde9650d2781a000001d0-1505728357.689909-1513033008', '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 03:21:16 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 03:21:16 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 03:21:16 INFO - Using env: {'DISPLAY': ':0', 03:21:16 INFO - 'HOME': '/home/cltbld', 03:21:16 INFO - 'LANG': 'en_US.UTF-8', 03:21:16 INFO - 'LANGUAGE': 'en_US:en', 03:21:16 INFO - 'LOGNAME': 'cltbld', 03:21:16 INFO - 'MAIL': '/var/mail/cltbld', 03:21:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:21:16 INFO - 'MOZ_NO_REMOTE': '1', 03:21:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:21:16 INFO - 'NO_EM_RESTART': '1', 03:21:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:21:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:21:16 INFO - 'PWD': '/builds/slave/test', 03:21:16 INFO - 'SHELL': '/bin/bash', 03:21:16 INFO - 'SHLVL': '1', 03:21:16 INFO - 'TERM': 'linux', 03:21:16 INFO - 'TMOUT': '86400', 03:21:16 INFO - 'USER': 'cltbld', 03:21:16 INFO - 'XDG_SESSION_COOKIE': '51fc86400edbde9650d2781a000001d0-1505728357.689909-1513033008', 03:21:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:21:16 INFO - '_': '/tools/buildbot/bin/python'} 03:21:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:21:16 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:21:16 INFO - Cleaning up... 03:21:16 INFO - Return code: 0 03:21:16 INFO - Running post-action listener: _resource_record_post_action 03:21:16 INFO - Running post-action listener: _start_resource_monitoring 03:21:16 INFO - Starting resource monitoring. 03:21:16 INFO - [mozharness: 2017-09-18 10:21:16.369799Z] Finished create-virtualenv step (success) 03:21:16 INFO - [mozharness: 2017-09-18 10:21:16.370311Z] Running install step. 03:21:16 INFO - Running pre-action listener: _resource_record_pre_action 03:21:16 INFO - Running main action method: install 03:21:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:21:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:21:16 INFO - Reading from file tmpfile_stdout 03:21:16 INFO - Detecting whether we're running mozinstall >=1.0... 03:21:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:21:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:21:16 INFO - Reading from file tmpfile_stdout 03:21:16 INFO - Output received: 03:21:16 INFO - Usage: mozinstall [options] installer 03:21:16 INFO - Options: 03:21:16 INFO - -h, --help show this help message and exit 03:21:16 INFO - -d DEST, --destination=DEST 03:21:16 INFO - Directory to install application into. [default: 03:21:16 INFO - "/builds/slave/test"] 03:21:16 INFO - --app=APP Application being installed. [default: firefox] 03:21:16 INFO - mkdir: /builds/slave/test/build/application 03:21:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 03:21:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 03:21:34 INFO - Reading from file tmpfile_stdout 03:21:34 INFO - Output received: 03:21:34 INFO - /builds/slave/test/build/application/firefox/firefox 03:21:34 INFO - Running post-action listener: _resource_record_post_action 03:21:34 INFO - [mozharness: 2017-09-18 10:21:34.470274Z] Finished install step (success) 03:21:34 INFO - [mozharness: 2017-09-18 10:21:34.470523Z] Running setup-mitmproxy step. 03:21:34 INFO - Running pre-action listener: _resource_record_pre_action 03:21:34 INFO - Running main action method: setup_mitmproxy 03:21:34 INFO - Skipping: mitmproxy is not required 03:21:34 INFO - Running post-action listener: _resource_record_post_action 03:21:34 INFO - [mozharness: 2017-09-18 10:21:34.471723Z] Finished setup-mitmproxy step (success) 03:21:34 INFO - [mozharness: 2017-09-18 10:21:34.471947Z] Running run-tests step. 03:21:34 INFO - Running pre-action listener: _resource_record_pre_action 03:21:34 INFO - Running pre-action listener: _set_gcov_prefix 03:21:34 INFO - Running main action method: run_tests 03:21:34 WARNING - Try message not found. 03:21:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:21:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:21:34 INFO - Python 2.7.3 03:21:34 INFO - Return code: 0 03:21:34 INFO - grabbing minidump binary from tooltool 03:21: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')]} 03:21:34 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 0x205f090>, '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 0x205fd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2059f90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:21:34 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 03:21:34 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 03:21:34 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 03:21:34 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:21:34 INFO - Return code: 0 03:21:34 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:21:34 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:21:34 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:21:34 INFO - ENV: RUST_BACKTRACE is now full 03:21:34 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:21:34 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:21:34 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/WN7zCNJvSaqvgRuYr4ZXkw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-082', '--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 03:21:34 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/WN7zCNJvSaqvgRuYr4ZXkw/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-082 --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 03:21:34 INFO - Using env: {'DISPLAY': ':0', 03:21:34 INFO - 'HOME': '/home/cltbld', 03:21:34 INFO - 'LANG': 'en_US.UTF-8', 03:21:34 INFO - 'LANGUAGE': 'en_US:en', 03:21:34 INFO - 'LOGNAME': 'cltbld', 03:21:34 INFO - 'MAIL': '/var/mail/cltbld', 03:21:34 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:21:34 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:21:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:21:34 INFO - 'MOZ_NO_REMOTE': '1', 03:21:34 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:21:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:21:34 INFO - 'NO_EM_RESTART': '1', 03:21:34 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:21:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:21:34 INFO - 'PWD': '/builds/slave/test', 03:21:34 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:21:34 INFO - 'RUST_BACKTRACE': 'full', 03:21:34 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 03:21:34 INFO - 'SHELL': '/bin/bash', 03:21:34 INFO - 'SHLVL': '1', 03:21:34 INFO - 'TERM': 'linux', 03:21:34 INFO - 'TMOUT': '86400', 03:21:34 INFO - 'USER': 'cltbld', 03:21:34 INFO - 'XDG_SESSION_COOKIE': '51fc86400edbde9650d2781a000001d0-1505728357.689909-1513033008', 03:21:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:21:34 INFO - '_': '/tools/buildbot/bin/python'} 03:21:34 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/WN7zCNJvSaqvgRuYr4ZXkw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-082', '--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 03:21:34 INFO - mozversion application_buildid: 20170918093138 03:21:34 INFO - mozversion application_changeset: 4ef69bbd6816d95ade430640785971f587e2d5bc 03:21:34 INFO - mozversion application_display_name: Nightly 03:21:34 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:21:34 INFO - mozversion application_name: Firefox 03:21:34 INFO - mozversion application_remotingname: firefox 03:21:34 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 03:21:34 INFO - mozversion application_vendor: Mozilla 03:21:34 INFO - mozversion application_version: 57.0a1 03:21:34 INFO - mozversion platform_buildid: 20170918093138 03:21:34 INFO - mozversion platform_changeset: 4ef69bbd6816d95ade430640785971f587e2d5bc 03:21:34 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 03:21:34 INFO - mozversion platform_version: 57.0a1 03:21:34 INFO - using testdate: 1505730094 03:21:34 INFO - actual date: 1505730094 03:21:34 INFO - starting webserver on 'localhost:37636' 03:21:34 INFO - SUITE-START | Running 2 tests 03:21:34 INFO - TEST-START | dromaeo_css 03:21:34 INFO - Initialising browser for dromaeo_css test... 03:21:34 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:37636/getInfo.html -profile /tmp/tmpD50csR/profile 03:21:34 INFO - TEST-INFO | started process 31793 (/builds/slave/test/build/application/firefox/firefox http://localhost:37636/getInfo.html) 03:21:40 INFO - TEST-INFO | 31793: exit 0 03:21:40 INFO - Browser initialized. 03:21:40 INFO - Running cycle 1/1 for dromaeo_css test... 03:21:40 INFO - Using env: {'DISPLAY': ':0', 03:21:40 INFO - 'HOME': '/home/cltbld', 03:21:40 INFO - 'JSGC_DISABLE_POISONING': '1', 03:21:40 INFO - 'LANG': 'en_US.UTF-8', 03:21:40 INFO - 'LANGUAGE': 'en_US:en', 03:21:40 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 03:21:40 INFO - 'LOGNAME': 'cltbld', 03:21:40 INFO - 'MAIL': '/var/mail/cltbld', 03:21:40 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:21:40 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:21:40 INFO - 'MOZ_CRASHREPORTER': '1', 03:21:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:21:40 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 03:21:40 INFO - 'MOZ_NO_REMOTE': '1', 03:21:40 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:21:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:21:40 INFO - 'NO_EM_RESTART': '1', 03:21:40 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:21:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:21:40 INFO - 'PWD': '/builds/slave/test', 03:21:40 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:21:40 INFO - 'RUST_BACKTRACE': 'full', 03:21:40 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 03:21:40 INFO - 'SHELL': '/bin/bash', 03:21:40 INFO - 'SHLVL': '1', 03:21:40 INFO - 'STYLO_FORCE_DISABLED': '1', 03:21:40 INFO - 'TERM': 'linux', 03:21:40 INFO - 'TMOUT': '86400', 03:21:40 INFO - 'USER': 'cltbld', 03:21:40 INFO - 'XDG_SESSION_COOKIE': '51fc86400edbde9650d2781a000001d0-1505728357.689909-1513033008', 03:21:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:21:40 INFO - '_': '/tools/buildbot/bin/python'} 03:21:40 INFO - TEST-INFO | started process 32023 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpD50csR/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 03:21:41 INFO - PID 32023 | 03:21:41 INFO - PID 32023 | (/builds/slave/test/build/application/firefox/firefox:32072): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 03:21:41 INFO - PID 32023 | 03:21:51 INFO - PID 32023 | RSS: Main: 156913664 03:21:51 INFO - PID 32023 | 03:24:49 INFO - PID 32023 | Cycle 1(1): loaded http://localhost:37636/tests/dromaeo/cssquery-dojo.html (next: http://localhost:37636/tests/dromaeo/cssquery-ext.html) 03:24:50 INFO - PID 32023 | RSS: Main: 156323840 03:24:50 INFO - PID 32023 | 03:27:51 INFO - PID 32023 | Cycle 1(1): loaded http://localhost:37636/tests/dromaeo/cssquery-ext.html (next: http://localhost:37636/tests/dromaeo/cssquery-jquery.html) 03:27:52 INFO - PID 32023 | RSS: Main: 156319744 03:27:52 INFO - PID 32023 | 03:30:54 INFO - PID 32023 | Cycle 1(1): loaded http://localhost:37636/tests/dromaeo/cssquery-jquery.html (next: http://localhost:37636/tests/dromaeo/cssquery-mootools.html) 03:30:54 INFO - PID 32023 | RSS: Main: 158138368 03:30:54 INFO - PID 32023 | 03:33:56 INFO - PID 32023 | Cycle 1(1): loaded http://localhost:37636/tests/dromaeo/cssquery-mootools.html (next: http://localhost:37636/tests/dromaeo/cssquery-prototype.html) 03:33:57 INFO - PID 32023 | RSS: Main: 156180480 03:33:57 INFO - PID 32023 | 03:37:00 INFO - PID 32023 | Cycle 1(1): loaded http://localhost:37636/tests/dromaeo/cssquery-prototype.html (next: http://localhost:37636/tests/dromaeo/cssquery-yui.html) 03:37:00 INFO - PID 32023 | RSS: Main: 158003200 03:37:00 INFO - PID 32023 | 03:40:02 INFO - PID 32023 | Cycle 1(1): loaded http://localhost:37636/tests/dromaeo/cssquery-yui.html (next: http://localhost:37636/tests/dromaeo/cssquery-dojo.html) 03:40:02 INFO - PID 32023 | RSS: Main: 160456704 03:40:02 INFO - PID 32023 | 03:40:02 INFO - PID 32023 | __start_tp_report 03:40:02 INFO - PID 32023 | _x_x_mozilla_page_load 03:40:02 INFO - PID 32023 | _x_x_mozilla_page_load_details 03:40:02 INFO - PID 32023 | |i|pagename|runs| 03:40:02 INFO - PID 32023 | |0;dojo.html;3151.6218053833545;3159.352332771782;3161.1938955566334;3164.7309978651815;3177.380410819891;6121.387861213876;6232.3144454110015;6239.313675495692;6300.275468321144;6393.680315984199;6259.342769009257;6268.279147897993;6303.590266632666;6306.117143599889;6311.747530098802;5802.65184088956;5813.128030795383;5819.7672093116435;5844.590878638497;5916.88166236675;5855.531557475391;5892.057270836645;5916.88166236675;5922.082077278029;5925.7925972590965;1108.24289125876;5621.8594535136535;5831.313765969549;5896.410358964112;5917.615355001933;5328.413874473805;5735.1970724098655;5753;5813.593048486608;5845.649261044351;5778;5795.8551036224435;5843.707814609295;5851.473367396955;5853.268341457318;6235.469985051276;6258.186435763367;6298.811035668938;6304.18045654062;6358.109864618911;6705.6982435790505;6719.529632925697;6770.221424536143;6803.693833777492;6813.965930170367;6654.633995130266;6780.966095169542;6790.830229244259;6804.115464989569;6891.586504809728;6344.936550634481;6347.365263473615;6358.491320694333;6361.618302901795;6371.267304260023;6929.5842249465195;6956.0609317741455;7032.5077244592385;7043.471739619446;7054.541454805421;6614.371634694697;6638.767643132467;6656.134702488743;6697.631630260285;6708.765193218214;6577.736890524421;6686;6688.799336019927;6693.899591506131;6715.294894036154;6583.80248592543;6622.569532980341;6703.028060931235;6739.494537909676;6764.357386048416;6752.257251702309;6780.8304792379595;6860.03959445668;6860.794176174722;6865.107536020286;5289.100852855024;5312.62811603184;5360.597955153379;5369.40936496985;5391.892162156735;4555.043440877386;4613.653975951817;4644.698094623838;4661.790219440133;4747.881302967385;5858.53131749459;5873.119032145212;5883.470487656132;5905.143754155623;5907.675077870673;6701.832454188587;6795.830104247335;6875.0718652982205;6878;6885.173779146535;5773.278340207474;5815.709214539256;5853.795117170878;5860.09168578871;5903.940960590425;5649.350324712628;5755.827325180251;5774.307083150049;5827.708614569255;5856.209411729447;6542.084108224757;6571.5399922005;6597.208334999735;6631.535792494479;6678.4991125665765;6748.223954245128;6772.830679233059;6775.186977562526;6845.699317129729;6890.276520965226;6555.246146693191;6556.967215163893;6578.342165783383;6664.333566643297;6679.899801502884;6503.122078519339;6589.604623722592;6594.208694956636;6614.90077648826;6615.17310336208;6681.164854393201;6704.66476676174;6708.765193218214;6736;6748.6963086660235;6523.543351965317;6533.248676402274;6685.130932978682;6689.8327541809895;6691.799246022627;6571.211454625475;6575.572587781779;6625.834354141185;6648.235452922976;6660.400563949268;6280.654563999024;6479.838004049748;6494.6103233806125;6569.24453687832;6582.637954912526;6552.803415897531;6578.04618330349;6642.535022548375;6671.799846004627;6704.4636429084585;6227.564070515021;6318.747250109944;6358.77744278948;6452;6460.483161346987 03:40:02 INFO - PID 32023 | |1;ext.html;857.0486759696736;880.058337578791;882.1311008656472;882.7219425880849;889.0398369760659;41143.79428102859;41811.372829407504;41970;41991.37012944804;41993.7900310498;38185.80907095461;38301.42547861784;38443.80778096113;38541.42187867184;38606;6940.9305906941045;7078.398336141434;7078.823029424254;7080.64596770162;7112.715491380339;6943.7569685061035;7070.8939365909555;7095.184053833824;7096.290370962914;7102.573845569256;7053.259407762188;7084.893726594105;7701.768946931573;7834.804129896741;7869.05571331441;7763.417743669219;7821;7821.96089019557;7843.254890785366;7849.25432083954;7508.774736757906;7568.091828980502;7690.846183076307;7693.923060769376;7719.768406947745;38147.42778858319;38498.422523662164;38511.614883851085;38516;38582;3468.236987862666;3491.9301613967577;3506.36885360635;3507.018034950218;3507.91230219244;30869.691303086907;31261.531077033862;31300.843495782603;31346.843265783526;31395.37209255802;5049.242613607951;5055.317532133152;5062.139436295838;5071.1632580624155;5146.125158723026;181820;182635;183711;184310;184337;45858.54141458543;45942.310865337044;46111.76944115258;46271;46343.304850427274;47523;47575.5242447578;48034.75982620064;48045.31841385535;48085;15929.601759955862;15964.361425542847;15985.36058557668;15992.440264590916;15998.280077396312;13348;13351.799723004162;13360.799588005993;13372.799408008888;13376.799348009788;13938.442462301597;13958.371873265727;14007.299635018207;14045.578632641038;14120.364583593762;5628.605997580212;5663.102860541682;5706.9714651426475;5739.8565035874435;5839.620424672383;991.7223177510165;994.6717583197527;1002.1481740520645;1015.7359086637528;1019.4393083803878;21916.45208869759;21999.780002200092;22062.448438789157;22322.665160022614;22605.886970565043;1087.90121976804;1093.2128867215592;1102.3771569063454;1104.1442881766695;1113.832925061231;11307.660770176908;11943.16397852142;11958.760824783629;11962.700932476757;12031.338276394883;228483;229180;229729;230656;231100;51226.74386628043;51305;51365;51610.22584661233;51646.96706065858;1324.7284306717293;1331.7735984882593;1472.1976522795317;1483.8367779544242;1487;27481.31296717598;27863.721362786113;28050.579241311803;28080.85959570189;28112;36095.63904361028;36211.094722632144;36248.27503449969;36263.45604815877;36266.27467450689;172017;173566;173660;174050;174231;33692.32615347728;33703.3259334807;33810.49284260689;33981.83009084939;33986;41399.7930010348;42231.577684222764;42297.788511057246;42626.573734263504;42763.358549622404;31146.377072458876;31178.22054448657;31250.687493124777;31287.217819554695;31673.84163079262;31915.840420797747;32083;32169.839150804095;32274;32493.35013299768;35392.46911296281;35739.82130089333;35782.8210858944;35808.46287305641;35827.82086089553;31155.844220778752;31256.843715781277;31317.686823131477;31324.53013204758;31664.683353166172;23237.58619486141;23402.297931062094;23472.882635586713;23739.762602373754;23830.64254036156 03:40:02 INFO - PID 32023 | |2;jquery.html;553.4852587094003;559.3790892109757;568.5508448325822;576.991345129823;609.3966972697029;21693.67459488107;22422.88788556057;22463.32610021702;22514.774852251474;22598.20906268281;23811.761882381215;24267.51464970704;24658.75341246587;25243.2427027189;25432.237032888996;6548;6727.66361681914;6734.1245638066985;6747.359000894907;6754.594724316532;6504.674766261692;6609;6627.469802415795;6939.201991770935;7248.855022899539;7246;7248.927510724904;7253.455990800685;7258.963705181493;7259.60072196029;7249.021382113427;7256.238095000054;7256.564606123623;7258.383037441824;7262;6644.468442524587;6940.514164008521;6946.097007389058;6955.408790252784;6956;30475.085747427613;31072.844635776903;31119;31126.688733112605;31144;2019.0611365714867;2019.5758890632985;2021.6057868715607;2023.61551305253;2029.7056926745686;21457.785422145735;21526.784732152635;21839.235626752987;22147.557048858933;22223.44441388962;2477.7274499805008;2497.6378425128437;2557.731438198981;2558.6545816314933;2558.846469211853;120622;125678.37160814229;144361.2781936094;146121;149028;20780.58438831215;20916.79083209179;21459.356219313446;22131.89340532967;23919.52160956806;42995.35506967398;43192.56807431948;43237.78381108074;43305.566944330785;43634.12731745347;11908.46411911466;11956.52173913051;11958.701032474257;12028.75942481163;12188.390580470941;10066.899331006744;10103;10177.898221017844;10219.489025548693;10285.691429257135;11159.386233757059;11358.26171298863;11655.009324207367;11860.644180674593;11979.880201197877;4049.2104039712563;4130.607592278729;4196.265323861766;4414.249577571756;4463.174312752151;941.6327632223438;972.1202311907734;974.7758015656439;979.2655508368723;980.6910823090703;19175.904120479587;19455.400750861136;19795.30716424918;19823.504412389804;20107.39677809668;1044.7597052677927;1049.1344640671325;1056.5562463765236;1056.9207309451822;1059.5443959097508;10785.13718902486;10866.185036122322;10877.891221087846;10943.23397362193;11102.61140860066;482278;491516;505751;517841;525834;104974.47512762387;106066.28767993083;106230;107101.46449267704;107381.46309268403;1173.9002184814387;1176.0474016047028;1182.8817118288275;1186.9287842729464;1190.476190476205;17553.03458309805;17748.55628609295;17921.73117403214;17973.460796176136;18036.36872709449;53302.46697532975;54622.726886365315;54809.45190548043;54917.45082549283;55716.72141639266;66769;67180;67460.32539674737;70442;72157.6392118036;19125.90437047806;19798.307059253435;19949.60100798005;20005;20060.799392005894;22586.661200081682;22644.886775566018;22767.65848512307;22989.425264368525;23015.424614384774;18019.099045047435;18119.45641630753;18310.725339119657;18364.72452913234;18383;16356.591085222488;16645.667086657955;17093.829061709224;17127.65744685124;17175.227114780115;17489.300427982736;17752.556186094935;18137.818621813614;18384.816151838844;18742.250309987994;19644.705329419783;19730.802691972898;19798;19841.801581983997;19902.70145947841;17730.82269177292;17833.286668533634;18233.908830456294;18452.169652365406;18454.26182952667 03:40:02 INFO - PID 32023 | |3;mootools.html;1306.7778477658796;1348.4201793228913;1355.4713661671947;1374.4776984745802;1375.7661197596408;14794.482193123229;15404.306806193721;15430.074195548275;15495.457658981937;15519.456819011337;15035.774463383059;15206.923965380158;15223.467178648749;15223.77164342533;15321.233938303096;2741.300968253093;2766.48819968306;2808.620836187109;2810;2815.9155225343275;2721.5781553859083;2780.402213524092;2785.7214278572183;2786.0527420676967;2793.6507936507937;2710.4443589064194;2727.045534063072;2822.167460599118;2826.1945345576514;2828.915132546027;2780;2811.6204312417867;2814.634097567324;2833.9291517712018;2834.093090211123;2648.801339899496;2672.5857492088758;2687.6640419947507;2707.431439397729;2708.5937109433544;14654.706905861824;14925.552233433014;14950.327235274439;14969.7754533681;15011.099334039993;8182.427230093896;8452.366072544522;8461.53461559614;8465.365097617641;8479;5381.192821076831;5577.661361273305;5616.887662246773;5652.3217213934595;5687.345955215162;1875.2124107874724;1894.5642502224566;1897.5540747924226;1931.2661188748327;1935;26498.602520962202;26560.070397535994;26731.33171670724;26752.929882804663;26756.866215668993;6775.356341147583;6901.344372284625;6978.651067446607;7076.115485564304;7116.50184487081;17005.574860628334;17067.48797536076;17107;17110.657786844193;17118.315267389164;7613.695452181962;7754.1470438251745;7757.9224207758325;7759.379249660014;7759.689612415553;7098.041764361848;7166.534175278694;7486.85026299471;7538.962305188439;7646.197149299243;5319.867003324948;5351.598630102758;5352.839414817562;5448.318960129984;5621.072523033654;1396.287893174468;1514.174774747765;1531.3491765999406;1562.9921850390904;1565.1782814022501;766.2720415605086;824.3858325547506;862.2756884217163;867.5488745852122;872.0625327772669;7109.146902371748;7208;7356.742514011984;7367.852642947111;7523;971.8007808399261;972.6741541583507;972.8686627305224;986.5807032011367;989.0356902020472;4471.910561788811;4511.390962220058;4546.863594092182;4554.157480866051;4599.862004139814;21769;22245.22141725032;22366;22392;22435.21476748306;20701.482462938246;21669.566608667737;21781;21873.12507499682;21914.780852191594;10640.095591874622;10671.092957098579;10700.411477368663;10758.838617420744;10760.730981725363;8253.83492330162;8570.871436928326;8603.612837422455;8627.8705819414;8630.309575233841;18781.154848032143;18875.433736987914;18917.90541047286;18956.43130706081;19177.32879349216;19394.224231031167;19538;19603.70594441056;19768.505787355432;20022.499437513598;10100.040496152853;10316.123129534073;10385.221108416748;10391.948040259751;10433.895661043596;13775.655608609864;13902.791458128338;13923.930380348034;13929.651758706113;13944.093633913762;11280.09759219244;11413.942930285295;11512.481938312963;11516.078713702716;11590.36253006059;10672.519736611715;10760.085392741705;10799.784004319712;11004.944975275072;11070.335779853234;9738.561764720464;9928.652497162564;9939.801203976025;9940.353876997971;9953.552090155816;7107.395871350993;7115.288471152843;7118.466115041496;7127.714891404493;7150.10623672041;7530.171681114964;7567.394608431202;7651.693932242648;7690.230976902265;7730.806729831575 03:40:02 INFO - PID 32023 | |4;prototype.html;484.9476635700527;524.1587252459802;525.6556955194347;530.14646419265;531.5402177116795;6312.242530896293;6339.636978049718;6353.52348573857;6382.297947225808;6398.840028999277;6140.171076904617;6242.906356404646;6299.055141728743;6330.936690633092;6344.8096557103245;5092.9745351273195;5119.692818430887;5163.63854530183;5191.428942816287;5192.610554208431;5059.190529515278;5102.489751024905;5131.307273518065;5148.2535032420465;5162.457941916082;4835.564799168074;4887.560119589236;4958.876028099308;4972.154733695281;4981.37732783402;4907.141250281186;4931.534232883522;4964.932539504024;4985.950140498585;4995.301597456864;4309.78451077448;4418.80115394808;4425.690201685883;4451.732896026248;4459.219636563621;6121.908171377433;6141.7543298268465;6164.167837341991;6167.41409566095;6222.3466536013975;5640.689762063085;5668.914966275509;5669.206311116447;5679.886402271973;5697.259356283698;6607.273199948002;6620.172478440195;6620.451126316355;6630.83422914431;6666.200055993263;4863.367762190928;4866.78099485524;4889.924216672326;4891.657583969123;4894.951050489485;6739.5282330236905;6824.93175068243;6851.931480685179;6938.618375989318;6968.825779355506;5388.676679399248;5446.128619420873;5470.507654311131;5489.6980666062955;5494.835154945358;5540.9168862467095;5559.77760889568;5565.582581306418;5569.275994120739;5585.664860108406;5981;6018.307894592091;6018.548608854353;6021.187139736167;6040.758369665252;6729.798106056826;6730.394264516119;6739.494537909676;6751.291114433012;6786.287439818748;1905.7141428785517;1912.129980858706;1914.6840771272862;1916.6933290673703;1922.8942408167686;1373.574192000483;1424.124163639375;1426.885849132067;1436.1957303909844;1443.4875619155048;5644.238027866268;5686.943130568724;5714.028615135437;5724.16999535065;5788.971055144697;6457.2574153971955;6550.901736473957;6664.666766661648;6664.700383425283;6752.93247067523;5739.540836733051;5740.512056475246;5789.160571717078;5806.938536819368;5843.649381037151;3503.1067077894972;3528.3648943190474;3578.481120237551;3584.2902595813207;3590.56913170416;6475.255345635218;6502.934970650327;6516.902246466212;6546.836329091716;6567.244766851778;6861.078897908594;6918.682241449071;6944.930550694529;6949.722011119599;6990.126234220723;6471.449926756279;6497.9675101625135;6518.478521718251;6570.474362050929;6584.341565843569;6658.1344425224415;6711.932880671131;6714.328567143247;6775.525713200029;6782.321767823376;6549.279579246374;6568.7372505099265;6602.735890564323;6666.766663166766;6726.764563240263;6503.51223658237;6511.38141876521;6515.511336649865;6530.934690653223;6535.274893310767;4944.208926571731;4946.4558898521855;4951.183054795918;4979.701217926791;4994.900101997867;6424.357564243538;6607.900881486686;6670.533062685566;6689.1972963244725;6689.5986240825705;6296.212973378328;6553.2136143663065;6608.603483790988;6640.568363056386;6650.634215118215;6475.643839588868;6479.773207937699;6482.384173503509;6574.605523668595;6642.435392991457;6294.779682711266;6340.587861788969;6393.936060639334;6430.903536446864;6440.550876052851;6432.067350234283;6596.538242323183;6614.933850661432;6655.534112612071;6714.294999025032;6333.1766870306565;6351.587146835441;6449.742010319723;6449.774257900951;6471.320511346241 03:40:02 INFO - PID 32023 | |5;yui.html;851.5401683091131;889.9644014239431;893.4014210478979;915.2860768600492;926.1386910173538;16892.1553922304;16894.66210675789;16954.321827126932;16954.491365259048;16959.57601059974;18347.449576512725;18455;18800.717989230172;18804.43586692398;19013.714794278098;949.753064203307;973.4208146153028;977.0522593084733;977.4233202410576;978.7063880835757;966.0436168193473;994.4431118573585;998.8102260570469;999.0658734083619;1001.2740762946878;1040.3081950502906;1048.1091072588276;1052.8578641883325;1053.489057806963;1054.973625659357;1048.114343379843;1050.0654417568371;1050.10216265093;1052.100454111735;1052.2844465763278;727.9854402911965;747.7345542332503;750.084896426359;752.6575408189261;774.8605251054807;20170.69743953842;20276;20334.593308133903;20356.18575257003;20375.388738337875;21409.67885481719;21429.249976250758;21777.455563610878;21797.891010545005;22065.11739530417;17809.7328540072;17851.107444627716;17860.821391786045;17966.19152138144;17974.460766177035;3737.009692431508;3764.811759412046;3767.095896984704;3767.698584113292;3767.8869633911027;134316.32841835826;134995.32502337426;135423;136421;136882.3155884224;14287.285635718172;15032.774508382383;15382.923085384726;15499.380024799108;15596.14221217844;25752.613710794354;30208.244793880327;30756;30771.69228307733;30825.383492330027;8420.452670576515;8423.199796019491;8459.534725590152;8465.153484651486;8520.19058189471;3995.1210733638554;4071.7353372030725;4120.114175452232;4139.710220284612;4150.979245103756;5174.172132458863;5177.844664660066;5248.291480650139;5254.710990895461;5302.39022512416;963.3112324687742;983.7934033852828;1001.1540248490014;1004.5032900977637;1006.2302338710892;656.2158220926043;668.913041304637;670.6479098473341;675.2234929830636;684.685044879361;11697.532098715956;11782.88217117835;11984.22102563348;12896.419661115273;13034.934825325812;632.9177206963066;637.7767781276609;646.1277275677797;646.683125268615;651.4202359899693;5631.352394474606;5676.2337084493065;5717.199592057115;5725.370209276976;5808.448197421239;123722;125500;126422;130418;131266;110568;111875;112418;114261.428692856;117797;92713.5364323174;94482.52758736162;94719.52640236754;94848;94930.5253473742;10590.046895779109;10602.257841951297;10697.51861166265;10725.141988641046;10900.236983411085;43881.34177987397;44187.55812441963;44588.55411445844;45783.31325030194;46876.7656161717;57366.7131664339;58003.70998144982;58514;59866;60277.69861150666;14396;14626.634334141732;14646.560603181922;14653;14720.631984200481;16236.18819059066;16450.67098657996;16533.91733041327;16619.50141495757;16648.3340666372;14326.785098223327;14376.928115359357;14632.926835365755;14756;14877.85122148808;14416.13503189812;14499.782503262248;14500.057496262709;14610.780838287646;14628.926855365655;13633.182009079486;14111.364988575333;14191.290435478391;14225.217613031382;14249.786253206003;11781.293122412682;11851;11865.5847045353;11981.341026243641;12128.454219560317;12071.456784444545;12207.267563946192;12382.62852114438;12433.689157771129;12514.624561263177 03:40:02 INFO - PID 32023 | __end_tp_report 03:40:02 INFO - PID 32023 | __start_cc_report 03:40:02 INFO - PID 32023 | _x_x_mozilla_cycle_collect,294 03:40:02 INFO - PID 32023 | __end_cc_report 03:40:02 INFO - PID 32023 | __startTimestamp1505731202770__endTimestamp 03:40:02 INFO - PID 32023 | 03:40:02 INFO - PID 32023 | ------- Summary: start ------- 03:40:02 INFO - PID 32023 | Number of tests: 6 03:40:02 INFO - PID 32023 | 03:40:02 INFO - PID 32023 | [#0] dojo.html Cycles:165 Average:6188.95 Median:6494.61 stddev:844.49 (13.0%) stddev-sans-first:812.77 03:40:02 INFO - PID 32023 | Values: 3151.6 3159.4 3161.2 3164.7 3177.4 6121.4 6232.3 6239.3 6300.3 6393.7 6259.3 6268.3 6303.6 6306.1 6311.7 5802.7 5813.1 5819.8 5844.6 5916.9 5855.5 5892.1 5916.9 5922.1 5925.8 1108.2 5621.9 5831.3 5896.4 5917.6 5328.4 5735.2 5753.0 5813.6 5845.6 5778.0 5795.9 5843.7 5851.5 5853.3 6235.5 6258.2 6298.8 6304.2 6358.1 6705.7 6719.5 6770.2 6803.7 6814.0 6654.6 6781.0 6790.8 6804.1 6891.6 6344.9 6347.4 6358.5 6361.6 6371.3 6929.6 6956.1 7032.5 7043.5 7054.5 6614.4 6638.8 6656.1 6697.6 6708.8 6577.7 6686.0 6688.8 6693.9 6715.3 6583.8 6622.6 6703.0 6739.5 6764.4 6752.3 6780.8 6860.0 6860.8 6865.1 5289.1 5312.6 5360.6 5369.4 5391.9 4555.0 4613.7 4644.7 4661.8 4747.9 5858.5 5873.1 5883.5 5905.1 5907.7 6701.8 6795.8 6875.1 6878.0 6885.2 5773.3 5815.7 5853.8 5860.1 5903.9 5649.4 5755.8 5774.3 5827.7 5856.2 6542.1 6571.5 6597.2 6631.5 6678.5 6748.2 6772.8 6775.2 6845.7 6890.3 6555.2 6557.0 6578.3 6664.3 6679.9 6503.1 6589.6 6594.2 6614.9 6615.2 6681.2 6704.7 6708.8 6736.0 6748.7 6523.5 6533.2 6685.1 6689.8 6691.8 6571.2 6575.6 6625.8 6648.2 6660.4 6280.7 6479.8 6494.6 6569.2 6582.6 6552.8 6578.0 6642.5 6671.8 6704.5 6227.6 6318.7 6358.8 6452.0 6460.5 03:40:02 INFO - PID 32023 | 03:40:02 INFO - PID 32023 | [#1] ext.html Cycles:180 Average:36373.25 Median:3506.69 stddev:51001.77 (1454.4%) stddev-sans-first:51075.11 03:40:02 INFO - PID 32023 | Values: 857.0 880.1 882.1 882.7 889.0 41143.8 41811.4 41970.0 41991.4 41993.8 38185.8 38301.4 38443.8 38541.4 38606.0 6940.9 7078.4 7078.8 7080.6 7112.7 6943.8 7070.9 7095.2 7096.3 7102.6 7053.3 7084.9 7701.8 7834.8 7869.1 7763.4 7821.0 7822.0 7843.3 7849.3 7508.8 7568.1 7690.8 7693.9 7719.8 38147.4 38498.4 38511.6 38516.0 38582.0 3468.2 3491.9 3506.4 3507.0 3507.9 30869.7 31261.5 31300.8 31346.8 31395.4 5049.2 5055.3 5062.1 5071.2 5146.1 181820.0 182635.0 183711.0 184310.0 184337.0 45858.5 45942.3 46111.8 46271.0 46343.3 47523.0 47575.5 48034.8 48045.3 48085.0 15929.6 15964.4 15985.4 15992.4 15998.3 13348.0 13351.8 13360.8 13372.8 13376.8 13938.4 13958.4 14007.3 14045.6 14120.4 5628.6 5663.1 5707.0 5739.9 5839.6 991.7 994.7 1002.1 1015.7 1019.4 21916.5 21999.8 22062.4 22322.7 22605.9 1087.9 1093.2 1102.4 1104.1 1113.8 11307.7 11943.2 11958.8 11962.7 12031.3 228483.0 229180.0 229729.0 230656.0 231100.0 51226.7 51305.0 51365.0 51610.2 51647.0 1324.7 1331.8 1472.2 1483.8 1487.0 27481.3 27863.7 28050.6 28080.9 28112.0 36095.6 36211.1 36248.3 36263.5 36266.3 172017.0 173566.0 173660.0 174050.0 174231.0 33692.3 33703.3 33810.5 33981.8 33986.0 41399.8 42231.6 42297.8 42626.6 42763.4 31146.4 31178.2 31250.7 31287.2 31673.8 31915.8 32083.0 32169.8 32274.0 32493.4 35392.5 35739.8 35782.8 35808.5 35827.8 31155.8 31256.8 31317.7 31324.5 31664.7 23237.6 23402.3 23472.9 23739.8 23830.6 03:40:02 INFO - PID 32023 | 03:40:02 INFO - PID 32023 | [#2] jquery.html Cycles:180 Average:36111.44 Median:21766.46 stddev:84385.06 (387.7%) stddev-sans-first:84579.55 03:40:02 INFO - PID 32023 | Values: 553.5 559.4 568.6 577.0 609.4 21693.7 22422.9 22463.3 22514.8 22598.2 23811.8 24267.5 24658.8 25243.2 25432.2 6548.0 6727.7 6734.1 6747.4 6754.6 6504.7 6609.0 6627.5 6939.2 7248.9 7246.0 7248.9 7253.5 7259.0 7259.6 7249.0 7256.2 7256.6 7258.4 7262.0 6644.5 6940.5 6946.1 6955.4 6956.0 30475.1 31072.8 31119.0 31126.7 31144.0 2019.1 2019.6 2021.6 2023.6 2029.7 21457.8 21526.8 21839.2 22147.6 22223.4 2477.7 2497.6 2557.7 2558.7 2558.8 120622.0 125678.4 144361.3 146121.0 149028.0 20780.6 20916.8 21459.4 22131.9 23919.5 42995.4 43192.6 43237.8 43305.6 43634.1 11908.5 11956.5 11958.7 12028.8 12188.4 10066.9 10103.0 10177.9 10219.5 10285.7 11159.4 11358.3 11655.0 11860.6 11979.9 4049.2 4130.6 4196.3 4414.2 4463.2 941.6 972.1 974.8 979.3 980.7 19175.9 19455.4 19795.3 19823.5 20107.4 1044.8 1049.1 1056.6 1056.9 1059.5 10785.1 10866.2 10877.9 10943.2 11102.6 482278.0 491516.0 505751.0 517841.0 525834.0 104974.5 106066.3 106230.0 107101.5 107381.5 1173.9 1176.0 1182.9 1186.9 1190.5 17553.0 17748.6 17921.7 17973.5 18036.4 53302.5 54622.7 54809.5 54917.5 55716.7 66769.0 67180.0 67460.3 70442.0 72157.6 19125.9 19798.3 19949.6 20005.0 20060.8 22586.7 22644.9 22767.7 22989.4 23015.4 18019.1 18119.5 18310.7 18364.7 18383.0 16356.6 16645.7 17093.8 17127.7 17175.2 17489.3 17752.6 18137.8 18384.8 18742.3 19644.7 19730.8 19798.0 19841.8 19902.7 17730.8 17833.3 18233.9 18452.2 18454.3 03:40:02 INFO - PID 32023 | 03:40:02 INFO - PID 32023 | [#3] mootools.html Cycles:180 Average:9328.84 Median:2716.01 stddev:6735.55 (248.0%) stddev-sans-first:6727.48 03:40:02 INFO - PID 32023 | Values: 1306.8 1348.4 1355.5 1374.5 1375.8 14794.5 15404.3 15430.1 15495.5 15519.5 15035.8 15206.9 15223.5 15223.8 15321.2 2741.3 2766.5 2808.6 2810.0 2815.9 2721.6 2780.4 2785.7 2786.1 2793.7 2710.4 2727.0 2822.2 2826.2 2828.9 2780.0 2811.6 2814.6 2833.9 2834.1 2648.8 2672.6 2687.7 2707.4 2708.6 14654.7 14925.6 14950.3 14969.8 15011.1 8182.4 8452.4 8461.5 8465.4 8479.0 5381.2 5577.7 5616.9 5652.3 5687.3 1875.2 1894.6 1897.6 1931.3 1935.0 26498.6 26560.1 26731.3 26752.9 26756.9 6775.4 6901.3 6978.7 7076.1 7116.5 17005.6 17067.5 17107.0 17110.7 17118.3 7613.7 7754.1 7757.9 7759.4 7759.7 7098.0 7166.5 7486.9 7539.0 7646.2 5319.9 5351.6 5352.8 5448.3 5621.1 1396.3 1514.2 1531.3 1563.0 1565.2 766.3 824.4 862.3 867.5 872.1 7109.1 7208.0 7356.7 7367.9 7523.0 971.8 972.7 972.9 986.6 989.0 4471.9 4511.4 4546.9 4554.2 4599.9 21769.0 22245.2 22366.0 22392.0 22435.2 20701.5 21669.6 21781.0 21873.1 21914.8 10640.1 10671.1 10700.4 10758.8 10760.7 8253.8 8570.9 8603.6 8627.9 8630.3 18781.2 18875.4 18917.9 18956.4 19177.3 19394.2 19538.0 19603.7 19768.5 20022.5 10100.0 10316.1 10385.2 10391.9 10433.9 13775.7 13902.8 13923.9 13929.7 13944.1 11280.1 11413.9 11512.5 11516.1 11590.4 10672.5 10760.1 10799.8 11004.9 11070.3 9738.6 9928.7 9939.8 9940.4 9953.6 7107.4 7115.3 7118.5 7127.7 7150.1 7530.2 7567.4 7651.7 7690.2 7730.8 03:40:02 INFO - PID 32023 | 03:40:02 INFO - PID 32023 | [#4] prototype.html Cycles:180 Average:5572.99 Median:6232.63 stddev:1523.26 (24.4%) stddev-sans-first:1478.88 03:40:02 INFO - PID 32023 | Values: 484.9 524.2 525.7 530.1 531.5 6312.2 6339.6 6353.5 6382.3 6398.8 6140.2 6242.9 6299.1 6330.9 6344.8 5093.0 5119.7 5163.6 5191.4 5192.6 5059.2 5102.5 5131.3 5148.3 5162.5 4835.6 4887.6 4958.9 4972.2 4981.4 4907.1 4931.5 4964.9 4986.0 4995.3 4309.8 4418.8 4425.7 4451.7 4459.2 6121.9 6141.8 6164.2 6167.4 6222.3 5640.7 5668.9 5669.2 5679.9 5697.3 6607.3 6620.2 6620.5 6630.8 6666.2 4863.4 4866.8 4889.9 4891.7 4895.0 6739.5 6824.9 6851.9 6938.6 6968.8 5388.7 5446.1 5470.5 5489.7 5494.8 5540.9 5559.8 5565.6 5569.3 5585.7 5981.0 6018.3 6018.5 6021.2 6040.8 6729.8 6730.4 6739.5 6751.3 6786.3 1905.7 1912.1 1914.7 1916.7 1922.9 1373.6 1424.1 1426.9 1436.2 1443.5 5644.2 5686.9 5714.0 5724.2 5789.0 6457.3 6550.9 6664.7 6664.7 6752.9 5739.5 5740.5 5789.2 5806.9 5843.6 3503.1 3528.4 3578.5 3584.3 3590.6 6475.3 6502.9 6516.9 6546.8 6567.2 6861.1 6918.7 6944.9 6949.7 6990.1 6471.4 6498.0 6518.5 6570.5 6584.3 6658.1 6711.9 6714.3 6775.5 6782.3 6549.3 6568.7 6602.7 6666.8 6726.8 6503.5 6511.4 6515.5 6530.9 6535.3 4944.2 4946.5 4951.2 4979.7 4994.9 6424.4 6607.9 6670.5 6689.2 6689.6 6296.2 6553.2 6608.6 6640.6 6650.6 6475.6 6479.8 6482.4 6574.6 6642.4 6294.8 6340.6 6393.9 6430.9 6440.6 6432.1 6596.5 6614.9 6655.5 6714.3 6333.2 6351.6 6449.7 6449.8 6471.3 03:40:02 INFO - PID 32023 | 03:40:02 INFO - PID 32023 | [#5] yui.html Cycles:180 Average:24216.83 Median:18627.86 stddev:35680.98 (191.5%) stddev-sans-first:35737.95 03:40:02 INFO - PID 32023 | Values: 851.5 890.0 893.4 915.3 926.1 16892.2 16894.7 16954.3 16954.5 16959.6 18347.4 18455.0 18800.7 18804.4 19013.7 949.8 973.4 977.1 977.4 978.7 966.0 994.4 998.8 999.1 1001.3 1040.3 1048.1 1052.9 1053.5 1055.0 1048.1 1050.1 1050.1 1052.1 1052.3 728.0 747.7 750.1 752.7 774.9 20170.7 20276.0 20334.6 20356.2 20375.4 21409.7 21429.2 21777.5 21797.9 22065.1 17809.7 17851.1 17860.8 17966.2 17974.5 3737.0 3764.8 3767.1 3767.7 3767.9 134316.3 134995.3 135423.0 136421.0 136882.3 14287.3 15032.8 15382.9 15499.4 15596.1 25752.6 30208.2 30756.0 30771.7 30825.4 8420.5 8423.2 8459.5 8465.2 8520.2 3995.1 4071.7 4120.1 4139.7 4151.0 5174.2 5177.8 5248.3 5254.7 5302.4 963.3 983.8 1001.2 1004.5 1006.2 656.2 668.9 670.6 675.2 684.7 11697.5 11782.9 11984.2 12896.4 13034.9 632.9 637.8 646.1 646.7 651.4 5631.4 5676.2 5717.2 5725.4 5808.4 123722.0 125500.0 126422.0 130418.0 131266.0 110568.0 111875.0 112418.0 114261.4 117797.0 92713.5 94482.5 94719.5 94848.0 94930.5 10590.0 10602.3 10697.5 10725.1 10900.2 43881.3 44187.6 44588.6 45783.3 46876.8 57366.7 58003.7 58514.0 59866.0 60277.7 14396.0 14626.6 14646.6 14653.0 14720.6 16236.2 16450.7 16533.9 16619.5 16648.3 14326.8 14376.9 14632.9 14756.0 14877.9 14416.1 14499.8 14500.1 14610.8 14628.9 13633.2 14111.4 14191.3 14225.2 14249.8 11781.3 11851.0 11865.6 11981.3 12128.5 12071.5 12207.3 12382.6 12433.7 12514.6 03:40:02 INFO - PID 32023 | -------- Summary: end -------- 03:40:02 INFO - PID 32023 | 03:40:03 INFO - TEST-INFO | 32023: exit 0 03:40:03 INFO - TEST-OK | dromaeo_css | took 1108574ms 03:40:03 INFO - TEST-START | kraken 03:40:03 INFO - Initialising browser for kraken test... 03:40:03 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:37636/getInfo.html -profile /tmp/tmpfIcDvs/profile 03:40:03 INFO - TEST-INFO | started process 32392 (/builds/slave/test/build/application/firefox/firefox http://localhost:37636/getInfo.html) 03:40:08 INFO - TEST-INFO | 32392: exit 0 03:40:08 INFO - Browser initialized. 03:40:08 INFO - Running cycle 1/1 for kraken test... 03:40:08 INFO - Using env: {'DISPLAY': ':0', 03:40:08 INFO - 'HOME': '/home/cltbld', 03:40:08 INFO - 'JSGC_DISABLE_POISONING': '1', 03:40:08 INFO - 'LANG': 'en_US.UTF-8', 03:40:08 INFO - 'LANGUAGE': 'en_US:en', 03:40:08 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 03:40:08 INFO - 'LOGNAME': 'cltbld', 03:40:08 INFO - 'MAIL': '/var/mail/cltbld', 03:40:08 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:40:08 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:40:08 INFO - 'MOZ_CRASHREPORTER': '1', 03:40:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:40:08 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 03:40:08 INFO - 'MOZ_NO_REMOTE': '1', 03:40:08 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:40:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:40:08 INFO - 'NO_EM_RESTART': '1', 03:40:08 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:40:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:40:08 INFO - 'PWD': '/builds/slave/test', 03:40:08 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:40:08 INFO - 'RUST_BACKTRACE': 'full', 03:40:08 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 03:40:08 INFO - 'SHELL': '/bin/bash', 03:40:08 INFO - 'SHLVL': '1', 03:40:08 INFO - 'STYLO_FORCE_DISABLED': '1', 03:40:08 INFO - 'TERM': 'linux', 03:40:08 INFO - 'TMOUT': '86400', 03:40:08 INFO - 'USER': 'cltbld', 03:40:08 INFO - 'XDG_SESSION_COOKIE': '51fc86400edbde9650d2781a000001d0-1505728357.689909-1513033008', 03:40:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:40:08 INFO - '_': '/tools/buildbot/bin/python'} 03:40:08 INFO - TEST-INFO | started process 32627 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfIcDvs/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 03:40:09 INFO - PID 32627 | 03:40:09 INFO - PID 32627 | (/builds/slave/test/build/application/firefox/firefox:32676): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 03:40:09 INFO - PID 32627 | 03:40:19 INFO - PID 32627 | RSS: Main: 156504064 03:40:19 INFO - PID 32627 | 03:40:22 INFO - PID 32627 | Cycle 1(1): loaded http://localhost:37636/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:37636/tests/kraken/driver.html?testName=audio-beat-detection) 03:40:23 INFO - PID 32627 | RSS: Main: 162828288 03:40:23 INFO - PID 32627 | 03:40:25 INFO - PID 32627 | Cycle 1(1): loaded http://localhost:37636/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:37636/tests/kraken/driver.html?testName=audio-dft) 03:40:26 INFO - PID 32627 | RSS: Main: 163057664 03:40:26 INFO - PID 32627 | 03:40:29 INFO - PID 32627 | Cycle 1(1): loaded http://localhost:37636/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:37636/tests/kraken/driver.html?testName=audio-fft) 03:40:29 INFO - PID 32627 | RSS: Main: 158732288 03:40:29 INFO - PID 32627 | 03:40:32 INFO - PID 32627 | Cycle 1(1): loaded http://localhost:37636/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:37636/tests/kraken/driver.html?testName=audio-oscillator) 03:40:32 INFO - PID 32627 | RSS: Main: 159600640 03:40:32 INFO - PID 32627 | 03:40:34 INFO - PID 32627 | Cycle 1(1): loaded http://localhost:37636/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:37636/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:40:35 INFO - PID 32627 | RSS: Main: 159514624 03:40:35 INFO - PID 32627 | 03:40:38 INFO - PID 32627 | Cycle 1(1): loaded http://localhost:37636/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:37636/tests/kraken/driver.html?testName=imaging-darkroom) 03:40:39 INFO - PID 32627 | RSS: Main: 162832384 03:40:39 INFO - PID 32627 | 03:40:42 INFO - PID 32627 | Cycle 1(1): loaded http://localhost:37636/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:37636/tests/kraken/driver.html?testName=imaging-desaturate) 03:40:43 INFO - PID 32627 | RSS: Main: 162533376 03:40:43 INFO - PID 32627 | 03:40:46 INFO - PID 32627 | Cycle 1(1): loaded http://localhost:37636/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:37636/tests/kraken/driver.html?testName=json-parse-financial) 03:40:47 INFO - PID 32627 | RSS: Main: 162066432 03:40:47 INFO - PID 32627 | 03:40:48 INFO - PID 32627 | Cycle 1(1): loaded http://localhost:37636/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:37636/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:40:49 INFO - PID 32627 | RSS: Main: 161984512 03:40:49 INFO - PID 32627 | 03:40:50 INFO - PID 32627 | Cycle 1(1): loaded http://localhost:37636/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:37636/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:40:51 INFO - PID 32627 | RSS: Main: 162017280 03:40:51 INFO - PID 32627 | 03:40:53 INFO - PID 32627 | Cycle 1(1): loaded http://localhost:37636/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:37636/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:40:54 INFO - PID 32627 | RSS: Main: 158953472 03:40:54 INFO - PID 32627 | 03:40:56 INFO - PID 32627 | Cycle 1(1): loaded http://localhost:37636/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:37636/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:40:57 INFO - PID 32627 | RSS: Main: 158871552 03:40:57 INFO - PID 32627 | 03:41:00 INFO - PID 32627 | Cycle 1(1): loaded http://localhost:37636/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:37636/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:41:00 INFO - PID 32627 | RSS: Main: 159584256 03:41:00 INFO - PID 32627 | 03:41:02 INFO - PID 32627 | Cycle 1(1): loaded http://localhost:37636/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:37636/tests/kraken/driver.html?testName=ai-astar) 03:41:03 INFO - PID 32627 | RSS: Main: 160452608 03:41:03 INFO - PID 32627 | 03:41:03 INFO - PID 32627 | __start_tp_report 03:41:03 INFO - PID 32627 | _x_x_mozilla_page_load 03:41:03 INFO - PID 32627 | _x_x_mozilla_page_load_details 03:41:03 INFO - PID 32627 | |i|pagename|runs| 03:41:03 INFO - PID 32627 | |0;ai-astar;109;108;107;108;109;112;108;107;107;107 03:41:03 INFO - PID 32627 | |1;audio-beat-detection;129;120;115;116;115;119;140;118;149;119 03:41:03 INFO - PID 32627 | |2;audio-dft;163;162;163;163;161;161;166;167;168;172 03:41:03 INFO - PID 32627 | |3;audio-fft;86;80;75;74;75;73;75;75;76;74 03:41:03 INFO - PID 32627 | |4;audio-oscillator;80;79;79;79;77;78;78;79;78;79 03:41:03 INFO - PID 32627 | |5;imaging-gaussian-blur;111;114;112;114;115;115;114;114;114;115 03:41:03 INFO - PID 32627 | |6;imaging-darkroom;148;147;147;147;148;148;148;148;149;148 03:41:03 INFO - PID 32627 | |7;imaging-desaturate;94;93;95;95;94;95;95;100;94;94 03:41:03 INFO - PID 32627 | |8;json-parse-financial;55;53;52;54;58;56;53;55;54;54 03:41:03 INFO - PID 32627 | |9;json-stringify-tinderbox;39;38;38;38;38;38;42;38;38;39 03:41:03 INFO - PID 32627 | |10;stanford-crypto-aes;73;76;72;77;74;74;76;75;74;74 03:41:03 INFO - PID 32627 | |11;stanford-crypto-ccm;113;111;111;115;116;111;112;125;112;126 03:41:03 INFO - PID 32627 | |12;stanford-crypto-pbkdf2;171;174;168;170;176;175;167;176;170;168 03:41:03 INFO - PID 32627 | |13;stanford-crypto-sha256-iterative;67;66;65;67;73;67;67;65;65;71 03:41:03 INFO - PID 32627 | __end_tp_report 03:41:03 INFO - PID 32627 | __start_cc_report 03:41:03 INFO - PID 32627 | _x_x_mozilla_cycle_collect,766 03:41:03 INFO - PID 32627 | __end_cc_report 03:41:03 INFO - PID 32627 | __startTimestamp1505731263031__endTimestamp 03:41:03 INFO - PID 32627 | 03:41:03 INFO - PID 32627 | ------- Summary: start ------- 03:41:03 INFO - PID 32627 | Number of tests: 14 03:41:03 INFO - PID 32627 | 03:41:03 INFO - PID 32627 | [#0] ai-astar Cycles:10 Average:108.20 Median:108.00 stddev:1.55 (1.4%) stddev-sans-first:1.62 03:41:03 INFO - PID 32627 | Values: 109.0 108.0 107.0 108.0 109.0 112.0 108.0 107.0 107.0 107.0 03:41:03 INFO - PID 32627 | 03:41:03 INFO - PID 32627 | [#1] audio-beat-detection Cycles:10 Average:124.00 Median:119.50 stddev:11.71 (9.8%) stddev-sans-first:12.28 03:41:03 INFO - PID 32627 | Values: 129.0 120.0 115.0 116.0 115.0 119.0 140.0 118.0 149.0 119.0 03:41:03 INFO - PID 32627 | 03:41:03 INFO - PID 32627 | [#2] audio-dft Cycles:10 Average:164.60 Median:164.50 stddev:3.57 (2.2%) stddev-sans-first:3.73 03:41:03 INFO - PID 32627 | Values: 163.0 162.0 163.0 163.0 161.0 161.0 166.0 167.0 168.0 172.0 03:41:03 INFO - PID 32627 | 03:41:03 INFO - PID 32627 | [#3] audio-fft Cycles:10 Average:76.30 Median:75.00 stddev:3.89 (5.2%) stddev-sans-first:1.99 03:41:03 INFO - PID 32627 | Values: 86.0 80.0 75.0 74.0 75.0 73.0 75.0 75.0 76.0 74.0 03:41:03 INFO - PID 32627 | 03:41:03 INFO - PID 32627 | [#4] audio-oscillator Cycles:10 Average:78.60 Median:79.00 stddev:0.84 (1.1%) stddev-sans-first:0.73 03:41:03 INFO - PID 32627 | Values: 80.0 79.0 79.0 79.0 77.0 78.0 78.0 79.0 78.0 79.0 03:41:03 INFO - PID 32627 | 03:41:03 INFO - PID 32627 | [#5] imaging-gaussian-blur Cycles:10 Average:113.80 Median:114.00 stddev:1.32 (1.2%) stddev-sans-first:0.93 03:41:03 INFO - PID 32627 | Values: 111.0 114.0 112.0 114.0 115.0 115.0 114.0 114.0 114.0 115.0 03:41:03 INFO - PID 32627 | 03:41:03 INFO - PID 32627 | [#6] imaging-darkroom Cycles:10 Average:147.80 Median:148.00 stddev:0.63 (0.4%) stddev-sans-first:0.67 03:41:03 INFO - PID 32627 | Values: 148.0 147.0 147.0 147.0 148.0 148.0 148.0 148.0 149.0 148.0 03:41:03 INFO - PID 32627 | 03:41:03 INFO - PID 32627 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:94.50 stddev:1.91 (2.0%) stddev-sans-first:2.00 03:41:03 INFO - PID 32627 | Values: 94.0 93.0 95.0 95.0 94.0 95.0 95.0 100.0 94.0 94.0 03:41:03 INFO - PID 32627 | 03:41:03 INFO - PID 32627 | [#8] json-parse-financial Cycles:10 Average:54.40 Median:54.50 stddev:1.71 (3.1%) stddev-sans-first:1.80 03:41:03 INFO - PID 32627 | Values: 55.0 53.0 52.0 54.0 58.0 56.0 53.0 55.0 54.0 54.0 03:41:03 INFO - PID 32627 | 03:41:03 INFO - PID 32627 | [#9] json-stringify-tinderbox Cycles:10 Average:38.60 Median:38.00 stddev:1.26 (3.3%) stddev-sans-first:1.33 03:41:03 INFO - PID 32627 | Values: 39.0 38.0 38.0 38.0 38.0 38.0 42.0 38.0 38.0 39.0 03:41:03 INFO - PID 32627 | 03:41:03 INFO - PID 32627 | [#10] stanford-crypto-aes Cycles:10 Average:74.50 Median:74.50 stddev:1.51 (2.0%) stddev-sans-first:1.50 03:41:03 INFO - PID 32627 | Values: 73.0 76.0 72.0 77.0 74.0 74.0 76.0 75.0 74.0 74.0 03:41:03 INFO - PID 32627 | 03:41:03 INFO - PID 32627 | [#11] stanford-crypto-ccm Cycles:10 Average:115.20 Median:114.00 stddev:5.69 (5.0%) stddev-sans-first:5.98 03:41:03 INFO - PID 32627 | Values: 113.0 111.0 111.0 115.0 116.0 111.0 112.0 125.0 112.0 126.0 03:41:03 INFO - PID 32627 | 03:41:03 INFO - PID 32627 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:171.50 Median:172.50 stddev:3.47 (2.0%) stddev-sans-first:3.68 03:41:03 INFO - PID 32627 | Values: 171.0 174.0 168.0 170.0 176.0 175.0 167.0 176.0 170.0 168.0 03:41:03 INFO - PID 32627 | 03:41:03 INFO - PID 32627 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.30 Median:67.00 stddev:2.67 (4.0%) stddev-sans-first:2.83 03:41:03 INFO - PID 32627 | Values: 67.0 66.0 65.0 67.0 73.0 67.0 67.0 65.0 65.0 71.0 03:41:03 INFO - PID 32627 | -------- Summary: end -------- 03:41:03 INFO - PID 32627 | 03:41:03 INFO - PID 32627 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 03:41:03 INFO - TEST-INFO | 32627: exit 0 03:41:03 INFO - TEST-OK | kraken | took 60245ms 03:41:03 INFO - SUITE-END | took 1168s 03:41:03 INFO - Completed test suite (00:19:28) 03:41:03 INFO - javascript benchmark 03:41:03 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s", "stylo_disabled"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8594.526924321573, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3151.6218053833545, 3159.352332771782, 3161.1938955566334, 3164.7309978651815, 3177.380410819891, 6121.387861213876, 6232.3144454110015, 6239.313675495692, 6300.275468321144, 6393.680315984199, 6259.342769009257, 6268.279147897993, 6303.590266632666, 6306.117143599889, 6311.747530098802, 5802.65184088956, 5813.128030795383, 5819.7672093116435, 5844.590878638497, 5916.88166236675, 5855.531557475391, 5892.057270836645, 5916.88166236675, 5922.082077278029, 5925.7925972590965, 1108.24289125876, 5621.8594535136535, 5831.313765969549, 5896.410358964112, 5917.615355001933, 5328.413874473805, 5735.1970724098655, 5753.0, 5813.593048486608, 5845.649261044351, 5778.0, 5795.8551036224435, 5843.707814609295, 5851.473367396955, 5853.268341457318, 6235.469985051276, 6258.186435763367, 6298.811035668938, 6304.18045654062, 6358.109864618911, 6705.6982435790505, 6719.529632925697, 6770.221424536143, 6803.693833777492, 6813.965930170367, 6654.633995130266, 6780.966095169542, 6790.830229244259, 6804.115464989569, 6891.586504809728, 6344.936550634481, 6347.365263473615, 6358.491320694333, 6361.618302901795, 6371.267304260023, 6929.5842249465195, 6956.0609317741455, 7032.5077244592385, 7043.471739619446, 7054.541454805421, 6614.371634694697, 6638.767643132467, 6656.134702488743, 6697.631630260285, 6708.765193218214, 6577.736890524421, 6686.0, 6688.799336019927, 6693.899591506131, 6715.294894036154, 6583.80248592543, 6622.569532980341, 6703.028060931235, 6739.494537909676, 6764.357386048416, 6752.257251702309, 6780.8304792379595, 6860.03959445668, 6860.794176174722, 6865.107536020286, 5289.100852855024, 5312.62811603184, 5360.597955153379, 5369.40936496985, 5391.892162156735, 4555.043440877386, 4613.653975951817, 4644.698094623838, 4661.790219440133, 4747.881302967385, 5858.53131749459, 5873.119032145212, 5883.470487656132, 5905.143754155623, 5907.675077870673, 6701.832454188587, 6795.830104247335, 6875.0718652982205, 6878.0, 6885.173779146535, 5773.278340207474, 5815.709214539256, 5853.795117170878, 5860.09168578871, 5903.940960590425, 5649.350324712628, 5755.827325180251, 5774.307083150049, 5827.708614569255, 5856.209411729447, 6542.084108224757, 6571.5399922005, 6597.208334999735, 6631.535792494479, 6678.4991125665765, 6748.223954245128, 6772.830679233059, 6775.186977562526, 6845.699317129729, 6890.276520965226, 6555.246146693191, 6556.967215163893, 6578.342165783383, 6664.333566643297, 6679.899801502884, 6503.122078519339, 6589.604623722592, 6594.208694956636, 6614.90077648826, 6615.17310336208, 6681.164854393201, 6704.66476676174, 6708.765193218214, 6736.0, 6748.6963086660235, 6523.543351965317, 6533.248676402274, 6685.130932978682, 6689.8327541809895, 6691.799246022627, 6571.211454625475, 6575.572587781779, 6625.834354141185, 6648.235452922976, 6660.400563949268, 6280.654563999024, 6479.838004049748, 6494.6103233806125, 6569.24453687832, 6582.637954912526, 6552.803415897531, 6578.04618330349, 6642.535022548375, 6671.799846004627, 6704.4636429084585, 6227.564070515021, 6318.747250109944, 6358.77744278948, 6452.0, 6460.483161346987], "value": 6127.710731949088, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [857.0486759696736, 880.058337578791, 882.1311008656472, 882.7219425880849, 889.0398369760659, 41143.79428102859, 41811.372829407504, 41970.0, 41991.37012944804, 41993.7900310498, 38185.80907095461, 38301.42547861784, 38443.80778096113, 38541.42187867184, 38606.0, 6940.9305906941045, 7078.398336141434, 7078.823029424254, 7080.64596770162, 7112.715491380339, 6943.7569685061035, 7070.8939365909555, 7095.184053833824, 7096.290370962914, 7102.573845569256, 7053.259407762188, 7084.893726594105, 7701.768946931573, 7834.804129896741, 7869.05571331441, 7763.417743669219, 7821.0, 7821.96089019557, 7843.254890785366, 7849.25432083954, 7508.774736757906, 7568.091828980502, 7690.846183076307, 7693.923060769376, 7719.768406947745, 38147.42778858319, 38498.422523662164, 38511.614883851085, 38516.0, 38582.0, 3468.236987862666, 3491.9301613967577, 3506.36885360635, 3507.018034950218, 3507.91230219244, 30869.691303086907, 31261.531077033862, 31300.843495782603, 31346.843265783526, 31395.37209255802, 5049.242613607951, 5055.317532133152, 5062.139436295838, 5071.1632580624155, 5146.125158723026, 181820.0, 182635.0, 183711.0, 184310.0, 184337.0, 45858.54141458543, 45942.310865337044, 46111.76944115258, 46271.0, 46343.304850427274, 47523.0, 47575.5242447578, 48034.75982620064, 48045.31841385535, 48085.0, 15929.601759955862, 15964.361425542847, 15985.36058557668, 15992.440264590916, 15998.280077396312, 13348.0, 13351.799723004162, 13360.799588005993, 13372.799408008888, 13376.799348009788, 13938.442462301597, 13958.371873265727, 14007.299635018207, 14045.578632641038, 14120.364583593762, 5628.605997580212, 5663.102860541682, 5706.9714651426475, 5739.8565035874435, 5839.620424672383, 991.7223177510165, 994.6717583197527, 1002.1481740520645, 1015.7359086637528, 1019.4393083803878, 21916.45208869759, 21999.780002200092, 22062.448438789157, 22322.665160022614, 22605.886970565043, 1087.90121976804, 1093.2128867215592, 1102.3771569063454, 1104.1442881766695, 1113.832925061231, 11307.660770176908, 11943.16397852142, 11958.760824783629, 11962.700932476757, 12031.338276394883, 228483.0, 229180.0, 229729.0, 230656.0, 231100.0, 51226.74386628043, 51305.0, 51365.0, 51610.22584661233, 51646.96706065858, 1324.7284306717293, 1331.7735984882593, 1472.1976522795317, 1483.8367779544242, 1487.0, 27481.31296717598, 27863.721362786113, 28050.579241311803, 28080.85959570189, 28112.0, 36095.63904361028, 36211.094722632144, 36248.27503449969, 36263.45604815877, 36266.27467450689, 172017.0, 173566.0, 173660.0, 174050.0, 174231.0, 33692.32615347728, 33703.3259334807, 33810.49284260689, 33981.83009084939, 33986.0, 41399.7930010348, 42231.577684222764, 42297.788511057246, 42626.573734263504, 42763.358549622404, 31146.377072458876, 31178.22054448657, 31250.687493124777, 31287.217819554695, 31673.84163079262, 31915.840420797747, 32083.0, 32169.839150804095, 32274.0, 32493.35013299768, 35392.46911296281, 35739.82130089333, 35782.8210858944, 35808.46287305641, 35827.82086089553, 31155.844220778752, 31256.843715781277, 31317.686823131477, 31324.53013204758, 31664.683353166172, 23237.58619486141, 23402.297931062094, 23472.882635586713, 23739.762602373754, 23830.64254036156], "value": 16874.034161993022, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [553.4852587094003, 559.3790892109757, 568.5508448325822, 576.991345129823, 609.3966972697029, 21693.67459488107, 22422.88788556057, 22463.32610021702, 22514.774852251474, 22598.20906268281, 23811.761882381215, 24267.51464970704, 24658.75341246587, 25243.2427027189, 25432.237032888996, 6548.0, 6727.66361681914, 6734.1245638066985, 6747.359000894907, 6754.594724316532, 6504.674766261692, 6609.0, 6627.469802415795, 6939.201991770935, 7248.855022899539, 7246.0, 7248.927510724904, 7253.455990800685, 7258.963705181493, 7259.60072196029, 7249.021382113427, 7256.238095000054, 7256.564606123623, 7258.383037441824, 7262.0, 6644.468442524587, 6940.514164008521, 6946.097007389058, 6955.408790252784, 6956.0, 30475.085747427613, 31072.844635776903, 31119.0, 31126.688733112605, 31144.0, 2019.0611365714867, 2019.5758890632985, 2021.6057868715607, 2023.61551305253, 2029.7056926745686, 21457.785422145735, 21526.784732152635, 21839.235626752987, 22147.557048858933, 22223.44441388962, 2477.7274499805008, 2497.6378425128437, 2557.731438198981, 2558.6545816314933, 2558.846469211853, 120622.0, 125678.37160814229, 144361.2781936094, 146121.0, 149028.0, 20780.58438831215, 20916.79083209179, 21459.356219313446, 22131.89340532967, 23919.52160956806, 42995.35506967398, 43192.56807431948, 43237.78381108074, 43305.566944330785, 43634.12731745347, 11908.46411911466, 11956.52173913051, 11958.701032474257, 12028.75942481163, 12188.390580470941, 10066.899331006744, 10103.0, 10177.898221017844, 10219.489025548693, 10285.691429257135, 11159.386233757059, 11358.26171298863, 11655.009324207367, 11860.644180674593, 11979.880201197877, 4049.2104039712563, 4130.607592278729, 4196.265323861766, 4414.249577571756, 4463.174312752151, 941.6327632223438, 972.1202311907734, 974.7758015656439, 979.2655508368723, 980.6910823090703, 19175.904120479587, 19455.400750861136, 19795.30716424918, 19823.504412389804, 20107.39677809668, 1044.7597052677927, 1049.1344640671325, 1056.5562463765236, 1056.9207309451822, 1059.5443959097508, 10785.13718902486, 10866.185036122322, 10877.891221087846, 10943.23397362193, 11102.61140860066, 482278.0, 491516.0, 505751.0, 517841.0, 525834.0, 104974.47512762387, 106066.28767993083, 106230.0, 107101.46449267704, 107381.46309268403, 1173.9002184814387, 1176.0474016047028, 1182.8817118288275, 1186.9287842729464, 1190.476190476205, 17553.03458309805, 17748.55628609295, 17921.73117403214, 17973.460796176136, 18036.36872709449, 53302.46697532975, 54622.726886365315, 54809.45190548043, 54917.45082549283, 55716.72141639266, 66769.0, 67180.0, 67460.32539674737, 70442.0, 72157.6392118036, 19125.90437047806, 19798.307059253435, 19949.60100798005, 20005.0, 20060.799392005894, 22586.661200081682, 22644.886775566018, 22767.65848512307, 22989.425264368525, 23015.424614384774, 18019.099045047435, 18119.45641630753, 18310.725339119657, 18364.72452913234, 18383.0, 16356.591085222488, 16645.667086657955, 17093.829061709224, 17127.65744685124, 17175.227114780115, 17489.300427982736, 17752.556186094935, 18137.818621813614, 18384.816151838844, 18742.250309987994, 19644.705329419783, 19730.802691972898, 19798.0, 19841.801581983997, 19902.70145947841, 17730.82269177292, 17833.286668533634, 18233.908830456294, 18452.169652365406, 18454.26182952667], "value": 12979.400317965326, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1306.7778477658796, 1348.4201793228913, 1355.4713661671947, 1374.4776984745802, 1375.7661197596408, 14794.482193123229, 15404.306806193721, 15430.074195548275, 15495.457658981937, 15519.456819011337, 15035.774463383059, 15206.923965380158, 15223.467178648749, 15223.77164342533, 15321.233938303096, 2741.300968253093, 2766.48819968306, 2808.620836187109, 2810.0, 2815.9155225343275, 2721.5781553859083, 2780.402213524092, 2785.7214278572183, 2786.0527420676967, 2793.6507936507937, 2710.4443589064194, 2727.045534063072, 2822.167460599118, 2826.1945345576514, 2828.915132546027, 2780.0, 2811.6204312417867, 2814.634097567324, 2833.9291517712018, 2834.093090211123, 2648.801339899496, 2672.5857492088758, 2687.6640419947507, 2707.431439397729, 2708.5937109433544, 14654.706905861824, 14925.552233433014, 14950.327235274439, 14969.7754533681, 15011.099334039993, 8182.427230093896, 8452.366072544522, 8461.53461559614, 8465.365097617641, 8479.0, 5381.192821076831, 5577.661361273305, 5616.887662246773, 5652.3217213934595, 5687.345955215162, 1875.2124107874724, 1894.5642502224566, 1897.5540747924226, 1931.2661188748327, 1935.0, 26498.602520962202, 26560.070397535994, 26731.33171670724, 26752.929882804663, 26756.866215668993, 6775.356341147583, 6901.344372284625, 6978.651067446607, 7076.115485564304, 7116.50184487081, 17005.574860628334, 17067.48797536076, 17107.0, 17110.657786844193, 17118.315267389164, 7613.695452181962, 7754.1470438251745, 7757.9224207758325, 7759.379249660014, 7759.689612415553, 7098.041764361848, 7166.534175278694, 7486.85026299471, 7538.962305188439, 7646.197149299243, 5319.867003324948, 5351.598630102758, 5352.839414817562, 5448.318960129984, 5621.072523033654, 1396.287893174468, 1514.174774747765, 1531.3491765999406, 1562.9921850390904, 1565.1782814022501, 766.2720415605086, 824.3858325547506, 862.2756884217163, 867.5488745852122, 872.0625327772669, 7109.146902371748, 7208.0, 7356.742514011984, 7367.852642947111, 7523.0, 971.8007808399261, 972.6741541583507, 972.8686627305224, 986.5807032011367, 989.0356902020472, 4471.910561788811, 4511.390962220058, 4546.863594092182, 4554.157480866051, 4599.862004139814, 21769.0, 22245.22141725032, 22366.0, 22392.0, 22435.21476748306, 20701.482462938246, 21669.566608667737, 21781.0, 21873.12507499682, 21914.780852191594, 10640.095591874622, 10671.092957098579, 10700.411477368663, 10758.838617420744, 10760.730981725363, 8253.83492330162, 8570.871436928326, 8603.612837422455, 8627.8705819414, 8630.309575233841, 18781.154848032143, 18875.433736987914, 18917.90541047286, 18956.43130706081, 19177.32879349216, 19394.224231031167, 19538.0, 19603.70594441056, 19768.505787355432, 20022.499437513598, 10100.040496152853, 10316.123129534073, 10385.221108416748, 10391.948040259751, 10433.895661043596, 13775.655608609864, 13902.791458128338, 13923.930380348034, 13929.651758706113, 13944.093633913762, 11280.09759219244, 11413.942930285295, 11512.481938312963, 11516.078713702716, 11590.36253006059, 10672.519736611715, 10760.085392741705, 10799.784004319712, 11004.944975275072, 11070.335779853234, 9738.561764720464, 9928.652497162564, 9939.801203976025, 9940.353876997971, 9953.552090155816, 7107.395871350993, 7115.288471152843, 7118.466115041496, 7127.714891404493, 7150.10623672041, 7530.171681114964, 7567.394608431202, 7651.693932242648, 7690.230976902265, 7730.806729831575], "value": 6657.819892936451, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [484.9476635700527, 524.1587252459802, 525.6556955194347, 530.14646419265, 531.5402177116795, 6312.242530896293, 6339.636978049718, 6353.52348573857, 6382.297947225808, 6398.840028999277, 6140.171076904617, 6242.906356404646, 6299.055141728743, 6330.936690633092, 6344.8096557103245, 5092.9745351273195, 5119.692818430887, 5163.63854530183, 5191.428942816287, 5192.610554208431, 5059.190529515278, 5102.489751024905, 5131.307273518065, 5148.2535032420465, 5162.457941916082, 4835.564799168074, 4887.560119589236, 4958.876028099308, 4972.154733695281, 4981.37732783402, 4907.141250281186, 4931.534232883522, 4964.932539504024, 4985.950140498585, 4995.301597456864, 4309.78451077448, 4418.80115394808, 4425.690201685883, 4451.732896026248, 4459.219636563621, 6121.908171377433, 6141.7543298268465, 6164.167837341991, 6167.41409566095, 6222.3466536013975, 5640.689762063085, 5668.914966275509, 5669.206311116447, 5679.886402271973, 5697.259356283698, 6607.273199948002, 6620.172478440195, 6620.451126316355, 6630.83422914431, 6666.200055993263, 4863.367762190928, 4866.78099485524, 4889.924216672326, 4891.657583969123, 4894.951050489485, 6739.5282330236905, 6824.93175068243, 6851.931480685179, 6938.618375989318, 6968.825779355506, 5388.676679399248, 5446.128619420873, 5470.507654311131, 5489.6980666062955, 5494.835154945358, 5540.9168862467095, 5559.77760889568, 5565.582581306418, 5569.275994120739, 5585.664860108406, 5981.0, 6018.307894592091, 6018.548608854353, 6021.187139736167, 6040.758369665252, 6729.798106056826, 6730.394264516119, 6739.494537909676, 6751.291114433012, 6786.287439818748, 1905.7141428785517, 1912.129980858706, 1914.6840771272862, 1916.6933290673703, 1922.8942408167686, 1373.574192000483, 1424.124163639375, 1426.885849132067, 1436.1957303909844, 1443.4875619155048, 5644.238027866268, 5686.943130568724, 5714.028615135437, 5724.16999535065, 5788.971055144697, 6457.2574153971955, 6550.901736473957, 6664.666766661648, 6664.700383425283, 6752.93247067523, 5739.540836733051, 5740.512056475246, 5789.160571717078, 5806.938536819368, 5843.649381037151, 3503.1067077894972, 3528.3648943190474, 3578.481120237551, 3584.2902595813207, 3590.56913170416, 6475.255345635218, 6502.934970650327, 6516.902246466212, 6546.836329091716, 6567.244766851778, 6861.078897908594, 6918.682241449071, 6944.930550694529, 6949.722011119599, 6990.126234220723, 6471.449926756279, 6497.9675101625135, 6518.478521718251, 6570.474362050929, 6584.341565843569, 6658.1344425224415, 6711.932880671131, 6714.328567143247, 6775.525713200029, 6782.321767823376, 6549.279579246374, 6568.7372505099265, 6602.735890564323, 6666.766663166766, 6726.764563240263, 6503.51223658237, 6511.38141876521, 6515.511336649865, 6530.934690653223, 6535.274893310767, 4944.208926571731, 4946.4558898521855, 4951.183054795918, 4979.701217926791, 4994.900101997867, 6424.357564243538, 6607.900881486686, 6670.533062685566, 6689.1972963244725, 6689.5986240825705, 6296.212973378328, 6553.2136143663065, 6608.603483790988, 6640.568363056386, 6650.634215118215, 6475.643839588868, 6479.773207937699, 6482.384173503509, 6574.605523668595, 6642.435392991457, 6294.779682711266, 6340.587861788969, 6393.936060639334, 6430.903536446864, 6440.550876052851, 6432.067350234283, 6596.538242323183, 6614.933850661432, 6655.534112612071, 6714.294999025032, 6333.1766870306565, 6351.587146835441, 6449.742010319723, 6449.774257900951, 6471.320511346241], "value": 5138.277790995366, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [851.5401683091131, 889.9644014239431, 893.4014210478979, 915.2860768600492, 926.1386910173538, 16892.1553922304, 16894.66210675789, 16954.321827126932, 16954.491365259048, 16959.57601059974, 18347.449576512725, 18455.0, 18800.717989230172, 18804.43586692398, 19013.714794278098, 949.753064203307, 973.4208146153028, 977.0522593084733, 977.4233202410576, 978.7063880835757, 966.0436168193473, 994.4431118573585, 998.8102260570469, 999.0658734083619, 1001.2740762946878, 1040.3081950502906, 1048.1091072588276, 1052.8578641883325, 1053.489057806963, 1054.973625659357, 1048.114343379843, 1050.0654417568371, 1050.10216265093, 1052.100454111735, 1052.2844465763278, 727.9854402911965, 747.7345542332503, 750.084896426359, 752.6575408189261, 774.8605251054807, 20170.69743953842, 20276.0, 20334.593308133903, 20356.18575257003, 20375.388738337875, 21409.67885481719, 21429.249976250758, 21777.455563610878, 21797.891010545005, 22065.11739530417, 17809.7328540072, 17851.107444627716, 17860.821391786045, 17966.19152138144, 17974.460766177035, 3737.009692431508, 3764.811759412046, 3767.095896984704, 3767.698584113292, 3767.8869633911027, 134316.32841835826, 134995.32502337426, 135423.0, 136421.0, 136882.3155884224, 14287.285635718172, 15032.774508382383, 15382.923085384726, 15499.380024799108, 15596.14221217844, 25752.613710794354, 30208.244793880327, 30756.0, 30771.69228307733, 30825.383492330027, 8420.452670576515, 8423.199796019491, 8459.534725590152, 8465.153484651486, 8520.19058189471, 3995.1210733638554, 4071.7353372030725, 4120.114175452232, 4139.710220284612, 4150.979245103756, 5174.172132458863, 5177.844664660066, 5248.291480650139, 5254.710990895461, 5302.39022512416, 963.3112324687742, 983.7934033852828, 1001.1540248490014, 1004.5032900977637, 1006.2302338710892, 656.2158220926043, 668.913041304637, 670.6479098473341, 675.2234929830636, 684.685044879361, 11697.532098715956, 11782.88217117835, 11984.22102563348, 12896.419661115273, 13034.934825325812, 632.9177206963066, 637.7767781276609, 646.1277275677797, 646.683125268615, 651.4202359899693, 5631.352394474606, 5676.2337084493065, 5717.199592057115, 5725.370209276976, 5808.448197421239, 123722.0, 125500.0, 126422.0, 130418.0, 131266.0, 110568.0, 111875.0, 112418.0, 114261.428692856, 117797.0, 92713.5364323174, 94482.52758736162, 94719.52640236754, 94848.0, 94930.5253473742, 10590.046895779109, 10602.257841951297, 10697.51861166265, 10725.141988641046, 10900.236983411085, 43881.34177987397, 44187.55812441963, 44588.55411445844, 45783.31325030194, 46876.7656161717, 57366.7131664339, 58003.70998144982, 58514.0, 59866.0, 60277.69861150666, 14396.0, 14626.634334141732, 14646.560603181922, 14653.0, 14720.631984200481, 16236.18819059066, 16450.67098657996, 16533.91733041327, 16619.50141495757, 16648.3340666372, 14326.785098223327, 14376.928115359357, 14632.926835365755, 14756.0, 14877.85122148808, 14416.13503189812, 14499.782503262248, 14500.057496262709, 14610.780838287646, 14628.926855365655, 13633.182009079486, 14111.364988575333, 14191.290435478391, 14225.217613031382, 14249.786253206003, 11781.293122412682, 11851.0, 11865.5847045353, 11981.341026243641, 12128.454219560317, 12071.456784444545, 12207.267563946192, 12382.62852114438, 12433.689157771129, 12514.624561263177], "value": 8777.77257222354, "unit": "score"}]}, {"extraOptions": ["e10s", "stylo_disabled"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1429.6999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 108.0, 107.0, 108.0, 109.0, 112.0, 108.0, 107.0, 107.0, 107.0], "value": 108.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [129.0, 120.0, 115.0, 116.0, 115.0, 119.0, 140.0, 118.0, 149.0, 119.0], "value": 124.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 162.0, 163.0, 163.0, 161.0, 161.0, 166.0, 167.0, 168.0, 172.0], "value": 164.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 80.0, 75.0, 74.0, 75.0, 73.0, 75.0, 75.0, 76.0, 74.0], "value": 76.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 79.0, 79.0, 79.0, 77.0, 78.0, 78.0, 79.0, 78.0, 79.0], "value": 78.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 114.0, 112.0, 114.0, 115.0, 115.0, 114.0, 114.0, 114.0, 115.0], "value": 113.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 147.0, 147.0, 147.0, 148.0, 148.0, 148.0, 148.0, 149.0, 148.0], "value": 147.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 93.0, 95.0, 95.0, 94.0, 95.0, 95.0, 100.0, 94.0, 94.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 53.0, 52.0, 54.0, 58.0, 56.0, 53.0, 55.0, 54.0, 54.0], "value": 54.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [39.0, 38.0, 38.0, 38.0, 38.0, 38.0, 42.0, 38.0, 38.0, 39.0], "value": 38.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 76.0, 72.0, 77.0, 74.0, 74.0, 76.0, 75.0, 74.0, 74.0], "value": 74.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 111.0, 111.0, 115.0, 116.0, 111.0, 112.0, 125.0, 112.0, 126.0], "value": 115.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 174.0, 168.0, 170.0, 176.0, 175.0, 167.0, 176.0, 170.0, 168.0], "value": 171.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 66.0, 65.0, 67.0, 73.0, 67.0, 67.0, 65.0, 65.0, 71.0], "value": 67.3, "unit": "score"}]}]} 03:41:03 INFO - Return code: 0 03:41:03 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:41:03 INFO - # TBPL SUCCESS # 03:41:03 INFO - Running post-action listener: _package_coverage_data 03:41:03 INFO - Running post-action listener: _resource_record_post_action 03:41:03 INFO - [mozharness: 2017-09-18 10:41:03.809786Z] Finished run-tests step (success) 03:41:03 INFO - Running post-run listener: _resource_record_post_run 03:41:03 INFO - Total resource usage - Wall time: 1187s; CPU: 13.0%; Read bytes: 4096; Write bytes: 344854528; Read time: 16; Write time: 217112 03:41:03 INFO - TinderboxPrint: CPU usage
13.1% 03:41:03 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 03:41:03 INFO - TinderboxPrint: I/O write bytes / time
344,854,528 / 217,112 03:41:03 INFO - TinderboxPrint: CPU idle
8,223.7 (86.9%) 03:41:03 INFO - TinderboxPrint: CPU user
1,191.3 (12.6%) 03:41:03 INFO - TinderboxPrint: Swap in / out
0 / 0 03:41:03 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 13234176; Read time: 0; Write time: 1292 03:41:03 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 03:41:03 INFO - run-tests - Wall time: 1169s; CPU: 13.0%; Read bytes: 0; Write bytes: 331620352; Read time: 0; Write time: 215820 03:41:04 INFO - Running post-run listener: _upload_blobber_files 03:41:04 INFO - Blob upload gear active. 03:41:04 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:41:04 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 03:41:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 03:41:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 03:41:04 INFO - (blobuploader) - INFO - Open directory for files ... 03:41:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log ... 03:41:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:41:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:41:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_raw.log: uploaded 03:41:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:41:05 INFO - (blobuploader) - INFO - Done attempting. 03:41:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:41:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:41:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:41:14 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:41:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:41:14 INFO - (blobuploader) - INFO - Done attempting. 03:41:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log ... 03:41:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:41:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:41:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_errorsummary.log: uploaded 03:41:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:41:15 INFO - (blobuploader) - INFO - Done attempting. 03:41:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 03:41:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:41:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:41:16 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 03:41:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:41:16 INFO - (blobuploader) - INFO - Done attempting. 03:41:16 INFO - (blobuploader) - INFO - Iteration through files over. 03:41:16 INFO - Return code: 0 03:41:16 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:41:16 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:41:16 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e631be0c2bffbd272ec7d0d04fd1d16373efdecbd53d8ebb8810a2d103489460f32de2c8ad01f721bcb7a22310c77d177657657af70b3b117758eef35457f16f", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/829176795065df901ca1ff22aa98298fe811342416103e1285226a38932b863b280a6d7463b467913172d5dff336640db58db15f45b34c7206b7e57917693174", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9d3c0491cc3ce5ed86539036ab139d4c330f27e0873163d72848db4a538c436589561d84cc7499299a80fc6517129ff19c1ad5f92978b351579422cdc9c60cae", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c74e8807e6f008d476b111989f1b042fd4ffdbd3b3a6bd55a7c70ca5c2b0116da03ce4532856dd16132819616a07b628d49b346f28a0d7592b804a12183587be"} 03:41:16 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:41:16 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:41:16 INFO - Contents: 03:41:16 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e631be0c2bffbd272ec7d0d04fd1d16373efdecbd53d8ebb8810a2d103489460f32de2c8ad01f721bcb7a22310c77d177657657af70b3b117758eef35457f16f", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/829176795065df901ca1ff22aa98298fe811342416103e1285226a38932b863b280a6d7463b467913172d5dff336640db58db15f45b34c7206b7e57917693174", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9d3c0491cc3ce5ed86539036ab139d4c330f27e0873163d72848db4a538c436589561d84cc7499299a80fc6517129ff19c1ad5f92978b351579422cdc9c60cae", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c74e8807e6f008d476b111989f1b042fd4ffdbd3b3a6bd55a7c70ca5c2b0116da03ce4532856dd16132819616a07b628d49b346f28a0d7592b804a12183587be"} 03:41:16 INFO - Running post-run listener: copy_logs_to_upload_dir 03:41:16 INFO - Copying logs to upload dir... 03:41:16 INFO - mkdir: /builds/slave/test/build/upload/logs 03:41:16 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1238.571127 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2017-09-18 03:41:17.071353) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-18 03:41:17.076462) ========= 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=51fc86400edbde9650d2781a000001d0-1505728357.689909-1513033008 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/e631be0c2bffbd272ec7d0d04fd1d16373efdecbd53d8ebb8810a2d103489460f32de2c8ad01f721bcb7a22310c77d177657657af70b3b117758eef35457f16f", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/829176795065df901ca1ff22aa98298fe811342416103e1285226a38932b863b280a6d7463b467913172d5dff336640db58db15f45b34c7206b7e57917693174", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9d3c0491cc3ce5ed86539036ab139d4c330f27e0873163d72848db4a538c436589561d84cc7499299a80fc6517129ff19c1ad5f92978b351579422cdc9c60cae", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c74e8807e6f008d476b111989f1b042fd4ffdbd3b3a6bd55a7c70ca5c2b0116da03ce4532856dd16132819616a07b628d49b346f28a0d7592b804a12183587be"} build_url:https://queue.taskcluster.net/v1/task/WN7zCNJvSaqvgRuYr4ZXkw/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011309 build_url: 'https://queue.taskcluster.net/v1/task/WN7zCNJvSaqvgRuYr4ZXkw/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e631be0c2bffbd272ec7d0d04fd1d16373efdecbd53d8ebb8810a2d103489460f32de2c8ad01f721bcb7a22310c77d177657657af70b3b117758eef35457f16f", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/829176795065df901ca1ff22aa98298fe811342416103e1285226a38932b863b280a6d7463b467913172d5dff336640db58db15f45b34c7206b7e57917693174", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9d3c0491cc3ce5ed86539036ab139d4c330f27e0873163d72848db4a538c436589561d84cc7499299a80fc6517129ff19c1ad5f92978b351579422cdc9c60cae", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c74e8807e6f008d476b111989f1b042fd4ffdbd3b3a6bd55a7c70ca5c2b0116da03ce4532856dd16132819616a07b628d49b346f28a0d7592b804a12183587be"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-18 03:41:17.106581) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-18 03:41:17.106903) ========= 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=51fc86400edbde9650d2781a000001d0-1505728357.689909-1513033008 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004501 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-18 03:41:17.189911) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-18 03:41:17.190235) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-18 03:41:17.190550) ========= ========= Total master_lag: 0.25 =========