builder: mozilla-central_ubuntu64_hw_qr_test-dromaeojs-e10s slave: talos-linux64-ix-077 starttime: 1505730025.37 results: success (0) revision: 4ef69bbd6816d95ade430640785971f587e2d5bc ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-18 03:20:25.370356) ========= 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:25.370790) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-18 03:20:25.371054) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-18 03:20:25.497593) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-18 03:20:25.497925) ========= 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=20e20d796406ba5117c4a6f1000001ba-1505728237.436665-1436425885 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-18 03:20:25-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.3M=0s 2017-09-18 03:20:25 (46.3 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.136921 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-18 03:20:25.666372) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-18 03:20:25.666673) ========= 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=20e20d796406ba5117c4a6f1000001ba-1505728237.436665-1436425885 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022432 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-18 03:20:25.750304) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 13 secs) (at 2017-09-18 03:20:25.750618) ========= 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=20e20d796406ba5117c4a6f1000001ba-1505728237.436665-1436425885 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-18 03:20:25,736 truncating revision to first 12 chars 2017-09-18 03:20:25,736 Setting DEBUG logging. 2017-09-18 03:20:25,736 attempt 1/10 2017-09-18 03:20:25,736 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:26,191 attempt 1/10 2017-09-18 03:20:26,981 current task status: no status available at this point. state: STARTED 2017-09-18 03:20:26,982 sleeping for 11.00s (attempt 1/10) 2017-09-18 03:20:37,993 attempt 2/10 2017-09-18 03:20:38,301 current task status: Task completed! Check 's3_urls' for upload locations. state: SUCCESS 2017-09-18 03:20:38,575 unpacking tar archive at: mozilla-central-4ef69bbd6816/testing/mozharness/ program finished with exit code 0 elapsedTime=13.291692 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 13 secs) (at 2017-09-18 03:20:39.057177) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-18 03:20:39.057457) ========= script_repo_revision: 4ef69bbd6816d95ade430640785971f587e2d5bc ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-18 03:20:39.057812) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-18 03:20:39.059108) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-18 03:20:39.074431) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2017-09-18 03:20:39.074702) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=20e20d796406ba5117c4a6f1000001ba-1505728237.436665-1436425885 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:20:39 INFO - MultiFileLogger online at 20170918 03:20:39 in /builds/slave/test 03:20:39 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 03:20:39 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:20:39 INFO - {'append_to_log': False, 03:20:39 INFO - 'base_work_dir': '/builds/slave/test', 03:20:39 INFO - 'blob_upload_branch': 'Firefox', 03:20:39 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:20:39 INFO - 'branch': 'Firefox', 03:20:39 INFO - 'buildbot_json_path': 'buildprops.json', 03:20:39 INFO - 'code_coverage': False, 03:20:39 INFO - 'config_files': ('talos/linux_config.py',), 03:20:39 INFO - 'default_actions': ('clobber', 03:20:39 INFO - 'read-buildbot-config', 03:20:39 INFO - 'download-and-extract', 03:20:39 INFO - 'populate-webroot', 03:20:39 INFO - 'create-virtualenv', 03:20:39 INFO - 'install', 03:20:39 INFO - 'setup-mitmproxy', 03:20:39 INFO - 'run-tests'), 03:20:39 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:20:39 INFO - 'disable_ccov_upload': False, 03:20:39 INFO - 'disable_stylo': False, 03:20:39 INFO - 'download_minidump_stackwalk': True, 03:20:39 INFO - 'download_symbols': 'ondemand', 03:20:39 INFO - 'enable_stylo': False, 03:20:39 INFO - 'enable_webrender': False, 03:20:39 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 03:20:39 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:20:39 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:20:39 INFO - 'gecko_profile': False, 03:20:39 INFO - 'gecko_profile_interval': 0, 03:20:39 INFO - 'installer_path': 'installer.exe', 03:20:39 INFO - 'log_level': 'info', 03:20:39 INFO - 'log_name': 'talos', 03:20:39 INFO - 'log_to_console': True, 03:20:39 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:20:39 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:20:39 INFO - 'opt_config_files': (), 03:20:39 INFO - 'pip_index': False, 03:20:39 INFO - 'suite': 'dromaeojs-e10s', 03:20:39 INFO - 'system_bits': '32', 03:20:39 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:20:39 INFO - 'title': 'talos-linux64-ix-077', 03:20:39 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:20:39 INFO - 'use_talos_json': True, 03:20:39 INFO - 'verify': 'False', 03:20:39 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:20:39 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:20:39 INFO - 'work_dir': 'build'} 03:20:39 INFO - [mozharness: 2017-09-18 10:20:39.207058Z] Running clobber step. 03:20:39 INFO - Running pre-action listener: _resource_record_pre_action 03:20:39 INFO - Running main action method: clobber 03:20:39 INFO - rmtree: /builds/slave/test/build 03:20:39 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.713734Z] Finished clobber step (success) 03:20:40 INFO - [mozharness: 2017-09-18 10:20:40.713831Z] 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_qr_test-dromaeojs-e10s", 03:20:40 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 03:20:40 INFO - "buildername": "Ubuntu HW 12.04 x64 qr mozilla-central talos dromaeojs-e10s", 03:20:40 INFO - "stage_platform": "linux64-qr", 03:20:40 INFO - "basedir": "/builds/slave/test", 03:20:40 INFO - "buildnumber": 73, 03:20:40 INFO - "platform": "ubuntu64_hw_qr", 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": "IEc_H3ZbQza_RrZ6bBgx6A", 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-077", 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/IEc_H3ZbQza_RrZ6bBgx6A'}, attempt #1 03:20:41 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/IEc_H3ZbQza_RrZ6bBgx6A'}, attempt #1 03:20:41 INFO - Task dependencies: WN7zCNJvSaqvgRuYr4ZXkw 03:20:41 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WN7zCNJvSaqvgRuYr4ZXkw'}, attempt #1 03:20:42 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/WN7zCNJvSaqvgRuYr4ZXkw/artifacts/public/build/target.tar.bz2 03:20:42 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/WN7zCNJvSaqvgRuYr4ZXkw/artifacts/public/build/target.test_packages.json 03:20:42 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/WN7zCNJvSaqvgRuYr4ZXkw/artifacts/public/build/target.crashreporter-symbols.zip 03:20:42 INFO - Running post-action listener: _resource_record_post_action 03:20:42 INFO - [mozharness: 2017-09-18 10:20:42.050549Z] Finished read-buildbot-config step (success) 03:20:42 INFO - [mozharness: 2017-09-18 10:20:42.050765Z] Running download-and-extract step. 03:20:42 INFO - Running pre-action listener: _resource_record_pre_action 03:20:42 INFO - Running main action method: download_and_extract 03:20:42 INFO - mkdir: /builds/slave/test/build/tests 03:20:42 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:42 INFO - trying https://queue.taskcluster.net/v1/task/WN7zCNJvSaqvgRuYr4ZXkw/artifacts/public/build/target.test_packages.json 03:20:42 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:42 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:42 INFO - Downloaded 989 bytes. 03:20:42 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 03:20:42 INFO - Using the following test package requirements: 03:20:42 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 03:20:42 INFO - u'common': [u'target.common.tests.zip'], 03:20:42 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 03:20:42 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 03:20:42 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 03:20:42 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 03:20:42 INFO - u'mozbase': [u'target.common.tests.zip'], 03:20:42 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 03:20:42 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 03:20:42 INFO - u'web-platform': [u'target.common.tests.zip', 03:20:42 INFO - u'target.web-platform.tests.tar.gz'], 03:20:42 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 03:20:42 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 03:20:42 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:42 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:42 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:54 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:54 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:54 INFO - Fetch https://queue.taskcluster.net/v1/task/WN7zCNJvSaqvgRuYr4ZXkw/artifacts/public/build/target.talos.tests.zip into memory 03:20:55 INFO - Content-Length response header: 14508748 03:20:55 INFO - Bytes received: 14508748 03:20:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:20:55 INFO - trying https://queue.taskcluster.net/v1/task/WN7zCNJvSaqvgRuYr4ZXkw/artifacts/public/build/target.tar.bz2 03:20:55 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:55 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.979001Z] Finished download-and-extract step (success) 03:20:56 INFO - [mozharness: 2017-09-18 10:20:56.979231Z] 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.997957Z] Finished populate-webroot step (success) 03:20:56 INFO - [mozharness: 2017-09-18 10:20:56.998047Z] 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:57 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:20:57 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 0x16ff1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18c8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a6ba60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a6f090>, '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 0x1a6fd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a69f90>, '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': '20e20d796406ba5117c4a6f1000001ba-1505728237.436665-1436425885', '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': '20e20d796406ba5117c4a6f1000001ba-1505728237.436665-1436425885', 03:20:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:20:57 INFO - '_': '/tools/buildbot/bin/python'} 03:20:59 INFO - Ignoring indexes: http://pypi.python.org/simple/ 03:20:59 INFO - Downloading/unpacking pip>=1.5 03:20:59 INFO - Running setup.py egg_info for package pip 03:20:59 INFO - warning: no files found matching 'pip/cacert.pem' 03:20:59 INFO - warning: no files found matching '*.html' under directory 'docs' 03:20:59 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 03:20:59 INFO - no previously-included directories found matching 'docs/_build/_sources' 03:20:59 INFO - Installing collected packages: pip 03:20:59 INFO - Found existing installation: pip 1.1 03:20:59 INFO - Uninstalling pip: 03:20:59 INFO - Successfully uninstalled pip 03:20:59 INFO - Running setup.py install for pip 03:20:59 INFO - warning: no files found matching 'pip/cacert.pem' 03:20:59 INFO - warning: no files found matching '*.html' under directory 'docs' 03:20:59 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 03:20:59 INFO - no previously-included directories found matching 'docs/_build/_sources' 03:20:59 INFO - Installing pip script to /builds/slave/test/build/venv/bin 03:20:59 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 03:20:59 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 03:20:59 INFO - Successfully installed pip 03:20:59 INFO - Cleaning up... 03:20:59 INFO - Return code: 0 03:20:59 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:20:59 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:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:20:59 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:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:20:59 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 0x16ff1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18c8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a6ba60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a6f090>, '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 0x1a6fd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a69f90>, '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': '20e20d796406ba5117c4a6f1000001ba-1505728237.436665-1436425885', '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:59 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:59 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:59 INFO - Using env: {'DISPLAY': ':0', 03:20:59 INFO - 'HOME': '/home/cltbld', 03:20:59 INFO - 'LANG': 'en_US.UTF-8', 03:20:59 INFO - 'LANGUAGE': 'en_US:en', 03:20:59 INFO - 'LOGNAME': 'cltbld', 03:20:59 INFO - 'MAIL': '/var/mail/cltbld', 03:20:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:20:59 INFO - 'MOZ_NO_REMOTE': '1', 03:20:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:20:59 INFO - 'NO_EM_RESTART': '1', 03:20:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:20:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:20:59 INFO - 'PWD': '/builds/slave/test', 03:20:59 INFO - 'SHELL': '/bin/bash', 03:20:59 INFO - 'SHLVL': '1', 03:20:59 INFO - 'TERM': 'linux', 03:20:59 INFO - 'TMOUT': '86400', 03:20:59 INFO - 'USER': 'cltbld', 03:20:59 INFO - 'XDG_SESSION_COOKIE': '20e20d796406ba5117c4a6f1000001ba-1505728237.436665-1436425885', 03:20:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:20:59 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:01 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 03:21:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:21:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:21:01 INFO - Successfully installed psutil 03:21:01 INFO - Cleaning up... 03:21:01 INFO - Return code: 0 03:21:01 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:21:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:21:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:21:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:21:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:21:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16ff1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18c8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a6ba60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a6f090>, '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 0x1a6fd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a69f90>, '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': '20e20d796406ba5117c4a6f1000001ba-1505728237.436665-1436425885', '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:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 03:21:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 03:21:01 INFO - Using env: {'DISPLAY': ':0', 03:21:01 INFO - 'HOME': '/home/cltbld', 03:21:01 INFO - 'LANG': 'en_US.UTF-8', 03:21:01 INFO - 'LANGUAGE': 'en_US:en', 03:21:01 INFO - 'LOGNAME': 'cltbld', 03:21:01 INFO - 'MAIL': '/var/mail/cltbld', 03:21:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:21:01 INFO - 'MOZ_NO_REMOTE': '1', 03:21:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:21:01 INFO - 'NO_EM_RESTART': '1', 03:21:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:21:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:21:01 INFO - 'PWD': '/builds/slave/test', 03:21:01 INFO - 'SHELL': '/bin/bash', 03:21:01 INFO - 'SHLVL': '1', 03:21:01 INFO - 'TERM': 'linux', 03:21:01 INFO - 'TMOUT': '86400', 03:21:01 INFO - 'USER': 'cltbld', 03:21:01 INFO - 'XDG_SESSION_COOKIE': '20e20d796406ba5117c4a6f1000001ba-1505728237.436665-1436425885', 03:21:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:21:01 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:03 INFO - Return code: 0 03:21:03 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:21:03 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:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:21:03 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:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:21:03 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 0x16ff1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18c8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a6ba60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a6f090>, '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 0x1a6fd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a69f90>, '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': '20e20d796406ba5117c4a6f1000001ba-1505728237.436665-1436425885', '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:03 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:03 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:03 INFO - Using env: {'DISPLAY': ':0', 03:21:03 INFO - 'HOME': '/home/cltbld', 03:21:03 INFO - 'LANG': 'en_US.UTF-8', 03:21:03 INFO - 'LANGUAGE': 'en_US:en', 03:21:03 INFO - 'LOGNAME': 'cltbld', 03:21:03 INFO - 'MAIL': '/var/mail/cltbld', 03:21:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:21:03 INFO - 'MOZ_NO_REMOTE': '1', 03:21:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:21:03 INFO - 'NO_EM_RESTART': '1', 03:21:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:21:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:21:03 INFO - 'PWD': '/builds/slave/test', 03:21:03 INFO - 'SHELL': '/bin/bash', 03:21:03 INFO - 'SHLVL': '1', 03:21:03 INFO - 'TERM': 'linux', 03:21:03 INFO - 'TMOUT': '86400', 03:21:03 INFO - 'USER': 'cltbld', 03:21:03 INFO - 'XDG_SESSION_COOKIE': '20e20d796406ba5117c4a6f1000001ba-1505728237.436665-1436425885', 03:21:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:21:03 INFO - '_': '/tools/buildbot/bin/python'} 03:21:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:21:03 INFO - Downloading/unpacking jsonschema==2.5.1 03:21:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:21:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:21:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:21:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 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:05 INFO - warning: no files found matching '*.txt' 03:21:05 INFO - no previously-included directories found matching 'build' 03:21:05 INFO - no previously-included directories found matching 'dist' 03:21:05 INFO - no previously-included directories found matching '.git*' 03:21:05 INFO - Successfully installed jsonschema functools32 03:21:05 INFO - Cleaning up... 03:21:05 INFO - Return code: 0 03:21:05 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:21:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:21:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:21:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:21:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:21:05 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 0x16ff1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18c8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a6ba60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a6f090>, '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 0x1a6fd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a69f90>, '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': '20e20d796406ba5117c4a6f1000001ba-1505728237.436665-1436425885', '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:05 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:05 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:05 INFO - Using env: {'DISPLAY': ':0', 03:21:05 INFO - 'HOME': '/home/cltbld', 03:21:05 INFO - 'LANG': 'en_US.UTF-8', 03:21:05 INFO - 'LANGUAGE': 'en_US:en', 03:21:05 INFO - 'LOGNAME': 'cltbld', 03:21:05 INFO - 'MAIL': '/var/mail/cltbld', 03:21:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:21:05 INFO - 'MOZ_NO_REMOTE': '1', 03:21:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:21:05 INFO - 'NO_EM_RESTART': '1', 03:21:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:21:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:21:05 INFO - 'PWD': '/builds/slave/test', 03:21:05 INFO - 'SHELL': '/bin/bash', 03:21:05 INFO - 'SHLVL': '1', 03:21:05 INFO - 'TERM': 'linux', 03:21:05 INFO - 'TMOUT': '86400', 03:21:05 INFO - 'USER': 'cltbld', 03:21:05 INFO - 'XDG_SESSION_COOKIE': '20e20d796406ba5117c4a6f1000001ba-1505728237.436665-1436425885', 03:21:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:21:05 INFO - '_': '/tools/buildbot/bin/python'} 03:21:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:21:05 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:21:05 INFO - Cleaning up... 03:21:05 INFO - Return code: 0 03:21:05 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:21:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:21:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:21:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:21:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:21:05 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 0x16ff1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18c8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a6ba60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a6f090>, '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 0x1a6fd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a69f90>, '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': '20e20d796406ba5117c4a6f1000001ba-1505728237.436665-1436425885', '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:05 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:05 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:05 INFO - Using env: {'DISPLAY': ':0', 03:21:05 INFO - 'HOME': '/home/cltbld', 03:21:05 INFO - 'LANG': 'en_US.UTF-8', 03:21:05 INFO - 'LANGUAGE': 'en_US:en', 03:21:05 INFO - 'LOGNAME': 'cltbld', 03:21:05 INFO - 'MAIL': '/var/mail/cltbld', 03:21:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:21:05 INFO - 'MOZ_NO_REMOTE': '1', 03:21:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:21:05 INFO - 'NO_EM_RESTART': '1', 03:21:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:21:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:21:05 INFO - 'PWD': '/builds/slave/test', 03:21:05 INFO - 'SHELL': '/bin/bash', 03:21:05 INFO - 'SHLVL': '1', 03:21:05 INFO - 'TERM': 'linux', 03:21:05 INFO - 'TMOUT': '86400', 03:21:05 INFO - 'USER': 'cltbld', 03:21:05 INFO - 'XDG_SESSION_COOKIE': '20e20d796406ba5117c4a6f1000001ba-1505728237.436665-1436425885', 03:21:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:21:05 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:07 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:21:07 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:07 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:07 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:07 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:07 INFO - Downloading docopt-0.6.1.tar.gz 03:21:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:21:07 INFO - Installing collected packages: blobuploader, requests, docopt 03:21:07 INFO - Running setup.py install for blobuploader 03:21:07 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:21:07 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:21:07 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 0x16ff1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18c8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a6ba60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a6f090>, '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 0x1a6fd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a69f90>, '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': '20e20d796406ba5117c4a6f1000001ba-1505728237.436665-1436425885', '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': '20e20d796406ba5117c4a6f1000001ba-1505728237.436665-1436425885', 03:21:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:21:07 INFO - '_': '/tools/buildbot/bin/python'} 03:21:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:21:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:21:08 INFO - Running setup.py (path:/tmp/pip-7wcwdL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:21:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:21:08 INFO - Running setup.py (path:/tmp/pip-7RvJL3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:21:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:21:08 INFO - Running setup.py (path:/tmp/pip-bDWrR9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:21:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:21:08 INFO - Running setup.py (path:/tmp/pip-k8wWPM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:21:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:21:08 INFO - Running setup.py (path:/tmp/pip-66PX6z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:21:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:21:08 INFO - Running setup.py (path:/tmp/pip-MoCtUk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:21:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:21:08 INFO - Running setup.py (path:/tmp/pip-bZN6Tc-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-mCwXNp-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-s0FJAn-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-3dw_MH-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-Jp02Fb-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-L3CZyI-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-jIZisq-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-u_gRMn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:21:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:21:09 INFO - Running setup.py (path:/tmp/pip-TvNerN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:21:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:21:09 INFO - Running setup.py (path:/tmp/pip-4nt5a4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:21:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:21:09 INFO - Running setup.py (path:/tmp/pip-Jbx5R7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:21:09 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:21:09 INFO - Running setup.py install for manifestparser 03:21:09 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:21:09 INFO - Running setup.py install for mozcrash 03:21:09 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:10 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:21:10 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:21:10 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:21:10 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:21:10 INFO - Running setup.py install for mozleak 03:21:10 INFO - Running setup.py install for mozlog 03:21:10 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:21:10 INFO - Running setup.py install for moznetwork 03:21:10 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:21:10 INFO - Running setup.py install for mozprocess 03:21:10 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:11 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:21:11 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:21:11 INFO - Cleaning up... 03:21:11 INFO - Return code: 0 03:21:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:21:11 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:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:21:11 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:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:21:11 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 0x16ff1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18c8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a6ba60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a6f090>, '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 0x1a6fd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a69f90>, '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': '20e20d796406ba5117c4a6f1000001ba-1505728237.436665-1436425885', '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:11 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:11 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:11 INFO - Using env: {'DISPLAY': ':0', 03:21:11 INFO - 'HOME': '/home/cltbld', 03:21:11 INFO - 'LANG': 'en_US.UTF-8', 03:21:11 INFO - 'LANGUAGE': 'en_US:en', 03:21:11 INFO - 'LOGNAME': 'cltbld', 03:21:11 INFO - 'MAIL': '/var/mail/cltbld', 03:21:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:21:11 INFO - 'MOZ_NO_REMOTE': '1', 03:21:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:21:11 INFO - 'NO_EM_RESTART': '1', 03:21:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:21:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:21:11 INFO - 'PWD': '/builds/slave/test', 03:21:11 INFO - 'SHELL': '/bin/bash', 03:21:11 INFO - 'SHLVL': '1', 03:21:11 INFO - 'TERM': 'linux', 03:21:11 INFO - 'TMOUT': '86400', 03:21:11 INFO - 'USER': 'cltbld', 03:21:11 INFO - 'XDG_SESSION_COOKIE': '20e20d796406ba5117c4a6f1000001ba-1505728237.436665-1436425885', 03:21:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:21:11 INFO - '_': '/tools/buildbot/bin/python'} 03:21:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:21:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:21:11 INFO - Running setup.py (path:/tmp/pip-rdwJI5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:21:11 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:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:21:11 INFO - Running setup.py (path:/tmp/pip-WTShlJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:21:11 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:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:21:11 INFO - Running setup.py (path:/tmp/pip-_pr4My-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:21:11 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:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:21:11 INFO - Running setup.py (path:/tmp/pip-VCWgwd-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-Rtwu4G-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-_K9GmB-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-h8qX6f-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-C7eXzc-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-1jAhRf-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-dTrxsN-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-Y2Tf6V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:21:12 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:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:21:12 INFO - Running setup.py (path:/tmp/pip-QUqV3W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:21:12 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:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:21:12 INFO - Running setup.py (path:/tmp/pip-ehz_Qt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:21:12 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:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:21:12 INFO - Running setup.py (path:/tmp/pip-xQarOE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:21:12 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:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:21:12 INFO - Running setup.py (path:/tmp/pip-80LvTd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:21:12 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:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:21:12 INFO - Running setup.py (path:/tmp/pip-Jgq3HN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:21:12 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:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:21:12 INFO - Running setup.py (path:/tmp/pip-kXvXp0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:21:12 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:12 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:12 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:12 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:12 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:12 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:12 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:12 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:21:12 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:12 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:12 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:12 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:14 INFO - Reading from file tmpfile_stdout 03:21:14 INFO - Current package versions: 03:21:14 INFO - argparse == 1.2.1 03:21:14 INFO - blessings == 1.6 03:21:14 INFO - blobuploader == 1.2.4 03:21:14 INFO - docopt == 0.6.1 03:21:14 INFO - functools32 == 3.2.3-2 03:21:14 INFO - jsonschema == 2.5.1 03:21:14 INFO - manifestparser == 1.1 03:21:14 INFO - mozInstall == 1.13 03:21:14 INFO - mozcrash == 1.0 03:21:14 INFO - mozdebug == 0.1 03:21:14 INFO - mozdevice == 0.51 03:21:14 INFO - mozfile == 1.2 03:21:14 INFO - mozhttpd == 0.7 03:21:14 INFO - mozinfo == 0.10 03:21:14 INFO - mozleak == 0.1 03:21:14 INFO - mozlog == 3.5 03:21:14 INFO - moznetwork == 0.27 03:21:14 INFO - mozprocess == 0.25 03:21:14 INFO - mozprofile == 0.28 03:21:14 INFO - mozrunner == 6.13 03:21:14 INFO - mozscreenshot == 0.1 03:21:14 INFO - mozsystemmonitor == 0.3 03:21:14 INFO - moztest == 0.8 03:21:14 INFO - mozversion == 1.4 03:21:14 INFO - psutil == 3.1.1 03:21:14 INFO - requests == 1.2.3 03:21:14 INFO - wsgiref == 0.1.2 03:21:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:21:14 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:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:21:14 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:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:21:14 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 0x16ff1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18c8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a6ba60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a6f090>, '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 0x1a6fd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a69f90>, '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': '20e20d796406ba5117c4a6f1000001ba-1505728237.436665-1436425885', '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:14 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:14 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:14 INFO - Using env: {'DISPLAY': ':0', 03:21:14 INFO - 'HOME': '/home/cltbld', 03:21:14 INFO - 'LANG': 'en_US.UTF-8', 03:21:14 INFO - 'LANGUAGE': 'en_US:en', 03:21:14 INFO - 'LOGNAME': 'cltbld', 03:21:14 INFO - 'MAIL': '/var/mail/cltbld', 03:21:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:21:14 INFO - 'MOZ_NO_REMOTE': '1', 03:21:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:21:14 INFO - 'NO_EM_RESTART': '1', 03:21:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:21:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:21:14 INFO - 'PWD': '/builds/slave/test', 03:21:14 INFO - 'SHELL': '/bin/bash', 03:21:14 INFO - 'SHLVL': '1', 03:21:14 INFO - 'TERM': 'linux', 03:21:14 INFO - 'TMOUT': '86400', 03:21:14 INFO - 'USER': 'cltbld', 03:21:14 INFO - 'XDG_SESSION_COOKIE': '20e20d796406ba5117c4a6f1000001ba-1505728237.436665-1436425885', 03:21:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:21:14 INFO - '_': '/tools/buildbot/bin/python'} 03:21:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:21:14 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:14 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:14 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:14 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:14 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:14 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:14 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:14 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:14 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:14 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 03:21:14 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:14 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:14 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:14 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:16 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 0x16ff1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18c8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a6ba60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a6f090>, '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 0x1a6fd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a69f90>, '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': '20e20d796406ba5117c4a6f1000001ba-1505728237.436665-1436425885', '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': '20e20d796406ba5117c4a6f1000001ba-1505728237.436665-1436425885', 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.744300Z] Finished create-virtualenv step (success) 03:21:16 INFO - [mozharness: 2017-09-18 10:21:16.744810Z] 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:17 INFO - Reading from file tmpfile_stdout 03:21:17 INFO - Output received: 03:21:17 INFO - Usage: mozinstall [options] installer 03:21:17 INFO - Options: 03:21:17 INFO - -h, --help show this help message and exit 03:21:17 INFO - -d DEST, --destination=DEST 03:21:17 INFO - Directory to install application into. [default: 03:21:17 INFO - "/builds/slave/test"] 03:21:17 INFO - --app=APP Application being installed. [default: firefox] 03:21:17 INFO - mkdir: /builds/slave/test/build/application 03:21:17 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:17 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:35 INFO - Reading from file tmpfile_stdout 03:21:35 INFO - Output received: 03:21:35 INFO - /builds/slave/test/build/application/firefox/firefox 03:21:35 INFO - Running post-action listener: _resource_record_post_action 03:21:35 INFO - [mozharness: 2017-09-18 10:21:35.031875Z] Finished install step (success) 03:21:35 INFO - [mozharness: 2017-09-18 10:21:35.032130Z] Running setup-mitmproxy step. 03:21:35 INFO - Running pre-action listener: _resource_record_pre_action 03:21:35 INFO - Running main action method: setup_mitmproxy 03:21:35 INFO - Skipping: mitmproxy is not required 03:21:35 INFO - Running post-action listener: _resource_record_post_action 03:21:35 INFO - [mozharness: 2017-09-18 10:21:35.033309Z] Finished setup-mitmproxy step (success) 03:21:35 INFO - [mozharness: 2017-09-18 10:21:35.033532Z] Running run-tests step. 03:21:35 INFO - Running pre-action listener: _resource_record_pre_action 03:21:35 INFO - Running pre-action listener: _set_gcov_prefix 03:21:35 INFO - Running main action method: run_tests 03:21:35 WARNING - Try message not found. 03:21:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:21:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:21:35 INFO - Python 2.7.3 03:21:35 INFO - Return code: 0 03:21:35 INFO - grabbing minidump binary from tooltool 03:21:35 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:35 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 0x1a6f090>, '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 0x1a6fd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a69f90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:21:35 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:35 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:35 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:35 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:21:35 INFO - Return code: 0 03:21:35 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:21:35 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:21:35 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:21:35 INFO - ENV: RUST_BACKTRACE is now full 03:21:35 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:21:35 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:21:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-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-077', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 03:21:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-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-077 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 03:21:35 INFO - Using env: {'DISPLAY': ':0', 03:21:35 INFO - 'HOME': '/home/cltbld', 03:21:35 INFO - 'LANG': 'en_US.UTF-8', 03:21:35 INFO - 'LANGUAGE': 'en_US:en', 03:21:35 INFO - 'LOGNAME': 'cltbld', 03:21:35 INFO - 'MAIL': '/var/mail/cltbld', 03:21:35 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:21:35 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:21:35 INFO - 'MOZ_ACCELERATED': '1', 03:21:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:21:35 INFO - 'MOZ_NO_REMOTE': '1', 03:21:35 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:21:35 INFO - 'MOZ_WEBRENDER': '1', 03:21:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:21:35 INFO - 'NO_EM_RESTART': '1', 03:21:35 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:21:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:21:35 INFO - 'PWD': '/builds/slave/test', 03:21:35 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:21:35 INFO - 'RUST_BACKTRACE': 'full', 03:21:35 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 03:21:35 INFO - 'SHELL': '/bin/bash', 03:21:35 INFO - 'SHLVL': '1', 03:21:35 INFO - 'TERM': 'linux', 03:21:35 INFO - 'TMOUT': '86400', 03:21:35 INFO - 'USER': 'cltbld', 03:21:35 INFO - 'XDG_SESSION_COOKIE': '20e20d796406ba5117c4a6f1000001ba-1505728237.436665-1436425885', 03:21:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:21:35 INFO - '_': '/tools/buildbot/bin/python'} 03:21:35 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-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-077', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 03:21:35 INFO - mozversion application_buildid: 20170918093138 03:21:35 INFO - mozversion application_changeset: 4ef69bbd6816d95ade430640785971f587e2d5bc 03:21:35 INFO - mozversion application_display_name: Nightly 03:21:35 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:21:35 INFO - mozversion application_name: Firefox 03:21:35 INFO - mozversion application_remotingname: firefox 03:21:35 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 03:21:35 INFO - mozversion application_vendor: Mozilla 03:21:35 INFO - mozversion application_version: 57.0a1 03:21:35 INFO - mozversion platform_buildid: 20170918093138 03:21:35 INFO - mozversion platform_changeset: 4ef69bbd6816d95ade430640785971f587e2d5bc 03:21:35 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 03:21:35 INFO - mozversion platform_version: 57.0a1 03:21:35 INFO - using testdate: 1505730095 03:21:35 INFO - actual date: 1505730095 03:21:35 INFO - starting webserver on 'localhost:44055' 03:21:35 INFO - SUITE-START | Running 2 tests 03:21:35 INFO - TEST-START | dromaeo_css 03:21:35 INFO - Initialising browser for dromaeo_css test... 03:21:35 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:44055/getInfo.html -profile /tmp/tmpaq27RQ/profile 03:21:35 INFO - TEST-INFO | started process 3534 (/builds/slave/test/build/application/firefox/firefox http://localhost:44055/getInfo.html) 03:21:42 INFO - TEST-INFO | 3534: exit 0 03:21:42 INFO - Browser initialized. 03:21:42 INFO - Running cycle 1/1 for dromaeo_css test... 03:21:42 INFO - Using env: {'DISPLAY': ':0', 03:21:42 INFO - 'HOME': '/home/cltbld', 03:21:42 INFO - 'JSGC_DISABLE_POISONING': '1', 03:21:42 INFO - 'LANG': 'en_US.UTF-8', 03:21:42 INFO - 'LANGUAGE': 'en_US:en', 03:21:42 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 03:21:42 INFO - 'LOGNAME': 'cltbld', 03:21:42 INFO - 'MAIL': '/var/mail/cltbld', 03:21:42 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:21:42 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:21:42 INFO - 'MOZ_ACCELERATED': '1', 03:21:42 INFO - 'MOZ_CRASHREPORTER': '1', 03:21:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:21:42 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 03:21:42 INFO - 'MOZ_NO_REMOTE': '1', 03:21:42 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:21:42 INFO - 'MOZ_WEBRENDER': '1', 03:21:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:21:42 INFO - 'NO_EM_RESTART': '1', 03:21:42 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:21:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:21:42 INFO - 'PWD': '/builds/slave/test', 03:21:42 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:21:42 INFO - 'RUST_BACKTRACE': 'full', 03:21:42 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 03:21:42 INFO - 'SHELL': '/bin/bash', 03:21:42 INFO - 'SHLVL': '1', 03:21:42 INFO - 'TERM': 'linux', 03:21:42 INFO - 'TMOUT': '86400', 03:21:42 INFO - 'USER': 'cltbld', 03:21:42 INFO - 'XDG_SESSION_COOKIE': '20e20d796406ba5117c4a6f1000001ba-1505728237.436665-1436425885', 03:21:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:21:42 INFO - '_': '/tools/buildbot/bin/python'} 03:21:42 INFO - TEST-INFO | started process 3776 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpaq27RQ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 03:21:42 INFO - PID 3776 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 03:21:43 INFO - PID 3776 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 03:21:43 INFO - PID 3776 | 03:21:43 INFO - PID 3776 | (/builds/slave/test/build/application/firefox/firefox:3835): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 03:21:43 INFO - PID 3776 | 03:21:53 INFO - PID 3776 | RSS: Main: 191557632 03:21:53 INFO - PID 3776 | 03:24:51 INFO - PID 3776 | Cycle 1(1): loaded http://localhost:44055/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44055/tests/dromaeo/cssquery-ext.html) 03:24:53 INFO - PID 3776 | RSS: Main: 193458176 03:24:53 INFO - PID 3776 | 03:27:55 INFO - PID 3776 | Cycle 1(1): loaded http://localhost:44055/tests/dromaeo/cssquery-ext.html (next: http://localhost:44055/tests/dromaeo/cssquery-jquery.html) 03:27:55 INFO - PID 3776 | RSS: Main: 197386240 03:27:55 INFO - PID 3776 | 03:30:57 INFO - PID 3776 | Cycle 1(1): loaded http://localhost:44055/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44055/tests/dromaeo/cssquery-mootools.html) 03:30:58 INFO - PID 3776 | RSS: Main: 195694592 03:30:58 INFO - PID 3776 | 03:34:00 INFO - PID 3776 | Cycle 1(1): loaded http://localhost:44055/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44055/tests/dromaeo/cssquery-prototype.html) 03:34:01 INFO - PID 3776 | RSS: Main: 191324160 03:34:01 INFO - PID 3776 | 03:37:04 INFO - PID 3776 | Cycle 1(1): loaded http://localhost:44055/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44055/tests/dromaeo/cssquery-yui.html) 03:37:05 INFO - PID 3776 | RSS: Main: 195280896 03:37:05 INFO - PID 3776 | 03:40:07 INFO - PID 3776 | Cycle 1(1): loaded http://localhost:44055/tests/dromaeo/cssquery-yui.html (next: http://localhost:44055/tests/dromaeo/cssquery-dojo.html) 03:40:07 INFO - PID 3776 | RSS: Main: 201318400 03:40:07 INFO - PID 3776 | 03:40:07 INFO - PID 3776 | __start_tp_report 03:40:07 INFO - PID 3776 | _x_x_mozilla_page_load 03:40:07 INFO - PID 3776 | _x_x_mozilla_page_load_details 03:40:07 INFO - PID 3776 | |i|pagename|runs| 03:40:07 INFO - PID 3776 | |0;dojo.html;3095.5047192449206;3110.8911188108423;3171.3498732759786;3172.50826121951;3173.825439600821;6119.449249567538;6287.15123458333;6300.716467758951;6312.305646378901;6327.7785277515295;6160.26076870775;6216.720247588858;6222.253329600454;6246.84382890428;6257.342978987209;5691.117876729093;5711.371749107595;5718.513926316268;5765.250517432749;5785.942140578603;5815.680137592431;5817.7963771267805;5832.737526811304;5842.64944103353;5855.209546711182;5737.397573254811;5785.363610002896;5814.069748840187;5829.387914268983;5829.650220986754;5567.331920169565;5634.746436410372;5636.351819540764;5757.078867381219;5879.1475236090955;5685.260916080924;5716.28546431696;5739.225204597367;5795.855103622401;5796.5362770978645;6103.87792244157;6197.225346831601;6209.3790620938;6313.558050936436;6325.968370158166;6631.502637302222;6635.635040072794;6668.86662266752;6676.365745254193;6747.426468750162;6700.664966751643;6774.729010839561;6784.525083244175;6814.48891333147;6819.727210911557;6212;6283.465905398047;6314.93685063148;6332.366763323676;6345.777897773602;6769.356911093439;6888.621125838127;6934.826629334307;6956.826079348057;6986;6333.493320534346;6511.641859697762;6523.347665233438;6556.967215163893;6684.766033188815;6557.147570815763;6574.704138313788;6617.205935287796;6639.900401493981;6668.266490686117;6643.5017373697165;6647.66761661915;6662.133922590032;6698.263191048981;6708.127943367429;6633.734650613921;6655.900161497581;6659.300773418819;6755.729770809211;6764.458843292525;5135.768890399941;5243.632945693841;5274.762635681327;5294.894102117936;5315.787368505294;4569.451665800125;4635.374224479652;4666.87994881226;4670.042641258534;4721.6458765592715;5772.769089236467;5778.335491418541;5815.709214539256;5819.243498345273;5836;6678.232003319583;6736.191657001191;6782.423494002966;6813.557118787263;6816.250212476623;5744.770209191669;5763.740631671585;5850.64896106235;5853.239078919798;5861;5646.2377579027125;5715.399883012307;5734.971325143348;5754.309482862;5799.5650326225705;6512.934870651327;6529.151210342625;6564.8358791030605;6600.768973085919;6609.074729537869;6657.3342665733035;6695.598264104169;6728.158980127484;6796.150481189851;6802.761903333359;6507.479401647762;6536.346365363425;6569.113169722026;6585.901211481927;6630.867382652416;6450.8064758057335;6578.901316480353;6580.80257592273;6633.1376920999965;6750.189977202767;6658.533902626769;6677.632730199885;6680;6691.297413771484;6723.7646682365885;6432.517561182836;6509.02364645307;6528.37980391862;6546.574472659262;6550.705218265094;6402.711877965409;6522.5760325578685;6533.118029066015;6564.8358791028695;6565.179352580927;6414.134091897721;6436.8390790230615;6517.576357536745;6530.47756179514;6539.280679125388;6354.078658594571;6426.068220108152;6512.381323774234;6551.21385433751;6590.934090659032;6328.46208072319;6343.841403964938;6349.174607301022;6356.650384228912;6390.680465976589 03:40:07 INFO - PID 3776 | |1;ext.html;791.4736700094437;807.2694211738371;819.4386845011171;821.392169794352;826.2316046077145;37353.81323093384;38011.42982855256;38158.23683526328;40134.19731605366;40730.7963460183;38685.41971870417;38833.611663883356;38959.41560876589;38992.80503597478;39078.21843563127;6983.895241571355;7001.649917504117;7090.50366474347;7107.538010029358;7123.180834204055;6910.619915904648;7657.234276572354;7780.14418413974;7795.493292935969;7848.803779905491;7780.727674531393;7809.960950195241;7813.570253636048;7814.765557033298;7829.843403131962;7692.3461505772075;7719.8070048248965;7767.8058048548955;7778.455508114434;7880.999999999943;7710.653020614086;7727.034120734908;7758.185390533969;7765.339946104588;7774.378049756063;37444;37768;37776.244475110616;37828.43257351142;37839.054023649354;3519.4017017107153;3524.013276282645;3525.982370088159;3530.1704099536587;3555.1112221944513;31637.84181079103;31656.208594785083;31685;31686.683133168604;31789;5098.7705553249825;5102.438731739506;5134.332536770196;5171.663841850268;5173.767180476888;182715;183482;183986;183997;184143;47418.525814742105;47812.760936195795;48080;48115.27827082597;48165.27752083722;43882;44967;49478.50521494811;51168.74415627898;51203.48796511987;14812.70374592502;15024.624384390478;15066.472673456376;15095.245237738069;15153.621159471102;11593.710157246136;11639;11644.708882278012;11663.533458661728;11696.824547631792;14456.710865782836;14484.637884052772;14523.709525809425;14742.11547307165;14896.180710061051;5839.9124013139835;5857.297124345106;5867.589268751147;5989.251343582052;6033.818985430444;989.3124278626285;992.8212921674168;1017.4048181813722;1019.9898001020043;1021.7343490692474;24042.278731638078;24187.879060604584;24206.273811785675;24317.036579226904;24404.87797561001;1103.906167975715;1110.4114819145866;1115.1524841120806;1118.3401792942202;1124.6232512108536;12518.37408129608;12527.812082818766;12533.498660053678;12576.559820406243;12584.685382865318;223744;224785;224787;225344;227453;47673.28490072652;47683.284750728766;47825.043499129824;47836.5216347839;47903.5209647906;1417.078898715843;1459.37246983798;1479.142097583399;1485.1534625263496;1495.0954672423245;22628.66057009113;22824.429389264737;22828.4292892679;23222.88388558114;23572.52854942926;32759.508607371386;34067.65932340645;36716.26567468689;36721.26557468889;36767.08082297857;190017;194138;198371;198782;201659;29780.55329170021;32067.198320042186;33297;33413.83293083519;33496.66503334935;42135.7893210532;42327.78836105923;42382.78808605937;42580;42880;31578.210544736565;31590.842045789625;31873.840630796698;31910;32752.67247327496;31400.842995784875;31713.5242971351;31723.682763172998;31737;31874.84062579672;34796;34839.30321393609;35060.12349691176;35526.64473355337;35586.64413355833;30869.536956946115;30902.84548577243;31140.22149446282;31140.68859311378;31379.05862824119;23523;23638.29085127449;23664.053437862294;24106.51786964286;24165.75834241635 03:40:07 INFO - PID 3776 | |2;jquery.html;568.1647977473114;569.9430056994298;573.8766165274468;578.7424596054755;581.1979468333699;21732.565348693017;22421;22423.878806059714;22480.213192538264;22669.09323627057;22693.319200424015;23841.403964900885;24096.397590060213;24137.15519956802;24250.393740156505;6333.999999999988;6466.838329041788;6477.740890364404;6515.837104072389;6521.413072823445;6430.260520040185;6434.420902118808;6453.709583068773;6500.154979852636;6509.056186852904;6125.693715314239;6349.42855143037;6447.516436267275;6455.2576453707725;6481.125048118491;6388.39310265524;6469.838254043663;6481.999999999976;6497.025446183063;6504.219493660744;5877.089051197071;5997.430244126845;6035.275766907999;6052.364501727299;6150.50795936324;27873.860630696716;28384;28418.431631367257;28464.857675711697;28476.28809279764;2002.5193953451067;2023.8886861222627;2024.5647185855112;2025.0381068992258;2025.1595587831032;18292.908535457238;18760.62478750431;19041.238350465967;19136.712949305773;19164.61670766577;2325.174563030117;2396.209250947183;2396.844205126661;2397.3527147670206;2440.5362981033722;114232;123360.38319808434;123781;131384;131944.99999999904;14015.229162395963;14290.78528325104;14368.497102601359;14642.780358294634;14834.184119873295;22254.777452225593;22287.331380058626;22341.218057367914;22355.441113971956;22480.662790058162;9026.684066057656;9287.953560232156;9313;9362.90637093634;9364.531773411438;8333.999840038468;8377.832443351099;8415.789605259917;8495.405321627426;8564.52895090776;8914.777130571787;8945.958374152819;8954.2836573074;8979.77550561228;9124.406913550598;2725.9927905978575;2744.2590500564734;2750.3811642380706;2753.2290958531644;2811.4377124575167;958.7363475044418;972.6060945317158;976.8827740671023;981.6711401680374;984.7538115471132;18218.45344639663;18340.174692138884;18457.70796044291;18566.350177743716;18839.81160188408;1027.106417416852;1027.9258175206926;1033.6278939581744;1038.200585549123;1039.7244730146517;10319;10336.224783141295;10498.800479807986;10511.369317840954;10648.467576621293;504760;508299;515310;515383;515979;105831;107838.46080769546;108220;108658;109091;1167.976640467203;1178.5816035307341;1212.8956260887353;1212.9878701213051;1213.4478812140455;16831.41090061842;16931.153442327588;16985.006778850067;17117.972921624743;17340;54133.646658833844;57113.71443142758;57309;57314;58141;69922.65038674774;70029.64985175042;70748.29251707623;70848;71816.64091679508;13746.381412836647;13761.17432954026;13783.173009619455;13802.102863313852;13857.861421385656;18398.81601183971;20799.68800467964;21666.133354665635;21693.891530542878;22082.779172208073;17390.73913891318;17542.561435963693;17746.91126544359;17821.376251831123;17891.19489622944;15375.538733838002;15558.377664893278;16211.189440528162;16265.186740663155;16393;17579.384721534683;17784.55538611545;17871.910640446713;17875.37436189727;17951.640967180323;13219.801702974655;13441.059125861488;13565.186088834702;13608.727825443633;13615.18308901469;16865;16969.915150424167;16979.405720799714;17081;17144.057076860394 03:40:07 INFO - PID 3776 | |3;mootools.html;1340.6782372230664;1407.3948202273025;1411.4565892131527;1423.2527922840502;1430.7353139669162;14850.33173507192;15168.241587920602;15724.135172565504;16222.675546489063;16245.918770406131;15816.604584885383;16049.91975040126;16109.113998730065;16151.757723634155;16172.27224774885;2771.4041481081613;2821.3510892494737;2834.3055951291963;2835;2838.8154769939993;2683.6511253537014;2879.9856000719965;2907.8546072696386;2924.722151395614;2927.736503714665;2799.986000070007;2807.143821134553;2849.843258620775;2850.401415702705;2853.144056782957;2799;2811.3533887205954;2834.3906060197055;2835.53213719736;2839.063109173968;2705.594160875865;2714.647095877543;2715.2125883493763;2723;2723.6459260296033;15114.319855606524;15118.319675614624;15173.468928587446;15264.771028434583;15323.31045102973;7988.480748751371;8322.334213262924;8353.164683531659;8367.330613550963;8368.3305335573;5380.542653874425;5534.861628459281;5636.71816409182;5724.084146536534;5782.653040817522;1889.1309997401213;1895.876768010075;1907.1799126375654;1945.9318923837739;1953.6385768632706;26664;26681.866590667116;26776.464470710478;26978.325541861414;27071.593926091125;6644.601323920484;6760.256371799098;6867.759628412981;6995.300469953066;7044;17480.737788933176;17507.47477575675;17602.735958960628;17604.29582816673;17619.735703964452;7772.18392068836;7950.0857401398425;8173.754787356389;8232.711855085163;8238.50568965864;7230.74692385764;7236.3487286143445;7337.41300695943;7354.816129596803;7377.594232317167;5246.816361427332;5318.25544423781;5320.414754377015;5381.354237491448;5411.648242864201;1556.3618916244286;1559.1502631065869;1561.9219039048003;1565.6633823727952;1597.7922870026823;867.8524650809378;869.9652013919373;895.6238379880466;897.3090720145582;904.8552231642906;7331.523450975669;7367.115946086396;7376.3730082942475;7379.262073792578;7415.629218539051;720.5892641194573;723.3815088099599;724.6376811594203;739.8113481062295;745.4446437404168;5084.9745751271;5169.224616307584;5211.973940130351;5270.183121616155;5557.166425036196;21070.473238168863;21339.89330053371;21564.245251416127;22316.665250021262;22325.77674223237;21193.576128477653;21728.913554322222;21734;21903.890480547812;21963.560728785335;10954.452277386099;11163.83254251187;11272.436378181059;11537.769244615229;11647.53409863613;8637.91362086371;8733;8813.91186088131;8867.290616750774;8902.42134261271;18203.362882299058;18795.154218059946;18891.43325700231;19280.132394042583;19522.8047719521;19538.120784564446;19561;19677.704834427208;19678.803211967697;19800;11182.32906025641;11348.943255283672;11354.659360218877;11364;11367.20429569922;13846.515371961934;14016.789748153582;14162.858371416567;14177.362018708976;14186.929065354607;11281.943590281997;11377.54489820398;11787.528498859949;11853.5851245206;11923.10576706733;11324.433778311217;11346.489407976826;11392.658220253406;11422.657320280405;11690.590829320932;10107.49462526856;10144.239182061523;10147.289689721649;10194.43930583825;10211.948940255252;7237.312455316736;7378.29906158914;7412.332890039922;7443.441741869273;7502.962485187539;7559.886601701089;7741.92258077412;7742.6128693566225;7765.145833958373;7804.648790804314 03:40:07 INFO - PID 3776 | |4;prototype.html;499.56873557258444;501.48347202381547;529.6663102245585;529.7483695244762;535.9094243215059;6245.469135123509;6287.842803929904;6290.49676025918;6306.432421082101;6319.368063193679;6180.567360284782;6193.814185574429;6221.59559628625;6230.190075290206;6288.685565721718;5142.485751424865;5143.897122057557;5144.17693169093;5155.974220128895;5175.094358487268;5075.162598171298;5166.896662066756;5186.662866913657;5188.066148093341;5189.688618682872;4798.160321943646;4891.853244402673;4918.1802732988845;4954.232094025432;5043.344365232515;4859.465458799529;4928.310036594879;4940.184869496528;4965.428975667808;4989.3513843200335;4339.7396156230725;4399.428074350314;4410.7429382626115;4470.977645111753;4484.798184081692;5831.650100993954;5972.761089556412;5986.191864098378;6006.039033754579;6027.246594175728;5564.3275438210585;5570.738385135374;5615.550755939515;5650.208970744099;5665.575081868835;6356.459700925427;6475.384838440341;6478.319776423455;6478.967605161991;6502.089707440962;4551.977240113812;4792.832250871237;4800.615950723934;4814.109389762905;4840.789802549362;6593.307702691196;6634.203895532519;6794.286599907037;6797.694103765342;6810.659467026679;4963.156263435225;4982.77577509013;4989.750512474362;4991.326170966873;5013.674111182761;4960.578350840146;4993.375828021497;5007.4241462231585;5013.298138260647;5027.648064635514;5512.91730624041;5625.746841392147;5641.8589535261945;5642.689652069093;5688.800891968761;6504.642244676494;6567.802965911031;6585.275619681831;6589.86820263592;6592.208934927839;1725.344369139744;1726.697827880116;1738.9913849966988;1745.4327343613122;1745.528707249061;1126.3129491010477;1198.8141838014947;1207.9094067944939;1208.6434501821984;1214.3745970825032;5560.916586251209;5604.775808967595;5617.438256174431;5641.661500309994;5649.774009039593;6489.480841532666;6595.967020164869;6604.306547812506;6620.536562440583;6623.271440141581;5560.610757247035;5589.692566908778;5600.383957764642;5630.465105814941;5642.235304700749;3402.4045791986305;3436.8453419596176;3452.7928324300624;3505.631908649606;3528.5709287738505;6426.550141490051;6472.093906853044;6479.384458476437;6494.220693516714;6526.216853977553;6733.966330168318;6737.6968036438475;6753.729850806011;6790.796276111724;6857.245702972669;6353.4599559038;6377.808665740035;6388.648624325707;6406.615603063831;6495.083950234692;5968.970155149196;6474.859693048962;6501.2198536175965;6503.544751867513;6541.803745887631;6286.705352546196;6353.809385718436;6385.936140638534;6470.255920569195;6480.837979050561;6325.367463253638;6364.886144924712;6368.299487056327;6395.744170233324;6399.8080057598345;4867.829625963216;4909.239067944474;4931.358923340086;4956.613397143482;4956.900861982812;6294.905576416266;6365.204349456318;6541.149650545399;6618.338166183343;6640.734370625121;6225.968870155621;6311.116443697794;6377.585456945284;6441.645709485836;6448.484121270381;6425.261094974137;6425.5502114851515;6427.871442571216;6467.741290348522;6496.870062598816;6262.843428914313;6268.620903401426;6311.526635502264;6365.777197798055;6393.474577541752;6338.809835704937;6368.936310636835;6392.264889537577;6403.903941440789;6518.392642942861;6164.321924588202;6194.389458740669;6270.561060725888;6281.748730050746;6346.20766862579 03:40:07 INFO - PID 3776 | |5;yui.html;885.2873436883307;896.556204678684;899.8751560549305;906.0758026812651;934.191923985752;17222.91388543057;17816.732749008774;17818.287268509277;17865.10674466278;17952.371666991658;17419.651606967855;17470;17500.737488937677;17756.023418711964;17757.822421775778;920.452330863137;939.8778158839341;945.2249155692335;946.0539460539461;954.1079091049855;973.8052389522123;975.0785507695231;979.480875136179;985.1675334342505;986.2849434160248;1031.9742006449862;1033.8139134955704;1034.689593122064;1034.9793004139913;1035.4822588705647;1004.2267454060369;1032.8554002439664;1039.1167507618538;1043.1133536493996;1043.5877828257871;746.1493896957472;746.8058304840727;747.249014740188;748.6294284329238;748.9063867016623;18789.060546972596;18910.62178756431;18998;19518.902405487883;20192.19231230749;20514.692279615818;20626.58746825055;20904.79095209059;20939.68590471144;20980;17807.910960445246;18155.54611134719;18207.635847283113;18213;18219.817801821944;3454.913627159316;3614.3132804767274;3658.0306218852024;3685.94471082934;3690.8892733218045;104761;105509;134114;138878;142572.99999999895;17850.5537361567;17974.191161397506;18051.819481805276;18228.54428639268;18317.084145792658;31314.21714457157;31712.682873171434;31758;31785.682143178274;32306.35387292288;9105.954470227607;9158;9172.770680733034;9193.172614464731;9238.445693258425;4218.535961044283;4355.216061108968;4367.606915377632;4378.78106094694;4393.978030109829;5379.919301210485;5476.424975377608;5480.342358916955;5540.390557038722;5570.6657600543285;1015.3958394755109;1033.7570670892335;1055.1453322808395;1056.2922841696081;1059.163261023798;649.1301655781276;662.3244290823333;672.6199697171082;681.7375310505392;687.6974131382176;11524.59663911759;11548.249363791327;11589.768204636028;12084.577039803564;12098.153129281041;676.3338111959715;678.6708446403491;683.2484267306023;694.1565997313188;695.151914664109;5484.369297530755;5492.862678433071;5518.530924871431;5579.218909352613;5610.943890561124;117847;120129;122659;123553;124578.37710811388;107860.460697696;108356.45821770841;111302;111394.44302778435;111527.44236278767;93766.53116734372;95058;96037.5198124019;97968;98478;10104.69685909424;10170.491475426346;10263.94868025685;10266.024727650862;10275.948620256851;41292.587074128875;42312;42659.57340426556;43006.56993430151;43902.78048609736;56012.43987560235;56597;57831.71084144552;57903.71048144732;58991;14640.194789286266;14653.487127950471;14693.412263509339;14708.264586770832;14793;16442.095684737455;16603.750943736097;16627.418040368528;16643.75034374461;16664.166791660125;14706.852931470976;14746.926265368604;14822;14991.2504374783;15002.774958375852;15742;15752.842471575137;15777.605559861095;15800;16068.598285042968;15405.152716600694;15472.5358239253;15519.068855868683;15581.143037132613;15728.134952577719;11130.220884538005;11423.086153107897;11536.769264614828;11548.538058477567;11674.299542027506;11679.357635330138;11737.765244695229;11931.880681193077;12134.393280336124;12187.756244874876 03:40:07 INFO - PID 3776 | __end_tp_report 03:40:07 INFO - PID 3776 | __start_cc_report 03:40:07 INFO - PID 3776 | _x_x_mozilla_cycle_collect,294 03:40:07 INFO - PID 3776 | __end_cc_report 03:40:07 INFO - PID 3776 | __startTimestamp1505731207692__endTimestamp 03:40:07 INFO - PID 3776 | 03:40:07 INFO - PID 3776 | ------- Summary: start ------- 03:40:07 INFO - PID 3776 | Number of tests: 6 03:40:07 INFO - PID 3776 | 03:40:07 INFO - PID 3776 | [#0] dojo.html Cycles:165 Average:6162.36 Median:6402.71 stddev:733.66 (11.5%) stddev-sans-first:695.34 03:40:07 INFO - PID 3776 | Values: 3095.5 3110.9 3171.3 3172.5 3173.8 6119.4 6287.2 6300.7 6312.3 6327.8 6160.3 6216.7 6222.3 6246.8 6257.3 5691.1 5711.4 5718.5 5765.3 5785.9 5815.7 5817.8 5832.7 5842.6 5855.2 5737.4 5785.4 5814.1 5829.4 5829.7 5567.3 5634.7 5636.4 5757.1 5879.1 5685.3 5716.3 5739.2 5795.9 5796.5 6103.9 6197.2 6209.4 6313.6 6326.0 6631.5 6635.6 6668.9 6676.4 6747.4 6700.7 6774.7 6784.5 6814.5 6819.7 6212.0 6283.5 6314.9 6332.4 6345.8 6769.4 6888.6 6934.8 6956.8 6986.0 6333.5 6511.6 6523.3 6557.0 6684.8 6557.1 6574.7 6617.2 6639.9 6668.3 6643.5 6647.7 6662.1 6698.3 6708.1 6633.7 6655.9 6659.3 6755.7 6764.5 5135.8 5243.6 5274.8 5294.9 5315.8 4569.5 4635.4 4666.9 4670.0 4721.6 5772.8 5778.3 5815.7 5819.2 5836.0 6678.2 6736.2 6782.4 6813.6 6816.3 5744.8 5763.7 5850.6 5853.2 5861.0 5646.2 5715.4 5735.0 5754.3 5799.6 6512.9 6529.2 6564.8 6600.8 6609.1 6657.3 6695.6 6728.2 6796.2 6802.8 6507.5 6536.3 6569.1 6585.9 6630.9 6450.8 6578.9 6580.8 6633.1 6750.2 6658.5 6677.6 6680.0 6691.3 6723.8 6432.5 6509.0 6528.4 6546.6 6550.7 6402.7 6522.6 6533.1 6564.8 6565.2 6414.1 6436.8 6517.6 6530.5 6539.3 6354.1 6426.1 6512.4 6551.2 6590.9 6328.5 6343.8 6349.2 6356.7 6390.7 03:40:07 INFO - PID 3776 | 03:40:07 INFO - PID 3776 | [#1] ext.html Cycles:180 Average:36627.13 Median:34817.65 stddev:52404.82 (150.5%) stddev-sans-first:52482.75 03:40:07 INFO - PID 3776 | Values: 791.5 807.3 819.4 821.4 826.2 37353.8 38011.4 38158.2 40134.2 40730.8 38685.4 38833.6 38959.4 38992.8 39078.2 6983.9 7001.6 7090.5 7107.5 7123.2 6910.6 7657.2 7780.1 7795.5 7848.8 7780.7 7810.0 7813.6 7814.8 7829.8 7692.3 7719.8 7767.8 7778.5 7881.0 7710.7 7727.0 7758.2 7765.3 7774.4 37444.0 37768.0 37776.2 37828.4 37839.1 3519.4 3524.0 3526.0 3530.2 3555.1 31637.8 31656.2 31685.0 31686.7 31789.0 5098.8 5102.4 5134.3 5171.7 5173.8 182715.0 183482.0 183986.0 183997.0 184143.0 47418.5 47812.8 48080.0 48115.3 48165.3 43882.0 44967.0 49478.5 51168.7 51203.5 14812.7 15024.6 15066.5 15095.2 15153.6 11593.7 11639.0 11644.7 11663.5 11696.8 14456.7 14484.6 14523.7 14742.1 14896.2 5839.9 5857.3 5867.6 5989.3 6033.8 989.3 992.8 1017.4 1020.0 1021.7 24042.3 24187.9 24206.3 24317.0 24404.9 1103.9 1110.4 1115.2 1118.3 1124.6 12518.4 12527.8 12533.5 12576.6 12584.7 223744.0 224785.0 224787.0 225344.0 227453.0 47673.3 47683.3 47825.0 47836.5 47903.5 1417.1 1459.4 1479.1 1485.2 1495.1 22628.7 22824.4 22828.4 23222.9 23572.5 32759.5 34067.7 36716.3 36721.3 36767.1 190017.0 194138.0 198371.0 198782.0 201659.0 29780.6 32067.2 33297.0 33413.8 33496.7 42135.8 42327.8 42382.8 42580.0 42880.0 31578.2 31590.8 31873.8 31910.0 32752.7 31400.8 31713.5 31723.7 31737.0 31874.8 34796.0 34839.3 35060.1 35526.6 35586.6 30869.5 30902.8 31140.2 31140.7 31379.1 23523.0 23638.3 23664.1 24106.5 24165.8 03:40:07 INFO - PID 3776 | 03:40:07 INFO - PID 3776 | [#2] jquery.html Cycles:180 Average:34291.78 Median:22422.44 stddev:85453.66 (381.1%) stddev-sans-first:85655.87 03:40:07 INFO - PID 3776 | Values: 568.2 569.9 573.9 578.7 581.2 21732.6 22421.0 22423.9 22480.2 22669.1 22693.3 23841.4 24096.4 24137.2 24250.4 6334.0 6466.8 6477.7 6515.8 6521.4 6430.3 6434.4 6453.7 6500.2 6509.1 6125.7 6349.4 6447.5 6455.3 6481.1 6388.4 6469.8 6482.0 6497.0 6504.2 5877.1 5997.4 6035.3 6052.4 6150.5 27873.9 28384.0 28418.4 28464.9 28476.3 2002.5 2023.9 2024.6 2025.0 2025.2 18292.9 18760.6 19041.2 19136.7 19164.6 2325.2 2396.2 2396.8 2397.4 2440.5 114232.0 123360.4 123781.0 131384.0 131945.0 14015.2 14290.8 14368.5 14642.8 14834.2 22254.8 22287.3 22341.2 22355.4 22480.7 9026.7 9288.0 9313.0 9362.9 9364.5 8334.0 8377.8 8415.8 8495.4 8564.5 8914.8 8946.0 8954.3 8979.8 9124.4 2726.0 2744.3 2750.4 2753.2 2811.4 958.7 972.6 976.9 981.7 984.8 18218.5 18340.2 18457.7 18566.4 18839.8 1027.1 1027.9 1033.6 1038.2 1039.7 10319.0 10336.2 10498.8 10511.4 10648.5 504760.0 508299.0 515310.0 515383.0 515979.0 105831.0 107838.5 108220.0 108658.0 109091.0 1168.0 1178.6 1212.9 1213.0 1213.4 16831.4 16931.2 16985.0 17118.0 17340.0 54133.6 57113.7 57309.0 57314.0 58141.0 69922.7 70029.6 70748.3 70848.0 71816.6 13746.4 13761.2 13783.2 13802.1 13857.9 18398.8 20799.7 21666.1 21693.9 22082.8 17390.7 17542.6 17746.9 17821.4 17891.2 15375.5 15558.4 16211.2 16265.2 16393.0 17579.4 17784.6 17871.9 17875.4 17951.6 13219.8 13441.1 13565.2 13608.7 13615.2 16865.0 16969.9 16979.4 17081.0 17144.1 03:40:07 INFO - PID 3776 | 03:40:07 INFO - PID 3776 | [#3] mootools.html Cycles:180 Average:9495.85 Median:14888.59 stddev:6780.55 (45.5%) stddev-sans-first:6771.88 03:40:07 INFO - PID 3776 | Values: 1340.7 1407.4 1411.5 1423.3 1430.7 14850.3 15168.2 15724.1 16222.7 16245.9 15816.6 16049.9 16109.1 16151.8 16172.3 2771.4 2821.4 2834.3 2835.0 2838.8 2683.7 2880.0 2907.9 2924.7 2927.7 2800.0 2807.1 2849.8 2850.4 2853.1 2799.0 2811.4 2834.4 2835.5 2839.1 2705.6 2714.6 2715.2 2723.0 2723.6 15114.3 15118.3 15173.5 15264.8 15323.3 7988.5 8322.3 8353.2 8367.3 8368.3 5380.5 5534.9 5636.7 5724.1 5782.7 1889.1 1895.9 1907.2 1945.9 1953.6 26664.0 26681.9 26776.5 26978.3 27071.6 6644.6 6760.3 6867.8 6995.3 7044.0 17480.7 17507.5 17602.7 17604.3 17619.7 7772.2 7950.1 8173.8 8232.7 8238.5 7230.7 7236.3 7337.4 7354.8 7377.6 5246.8 5318.3 5320.4 5381.4 5411.6 1556.4 1559.2 1561.9 1565.7 1597.8 867.9 870.0 895.6 897.3 904.9 7331.5 7367.1 7376.4 7379.3 7415.6 720.6 723.4 724.6 739.8 745.4 5085.0 5169.2 5212.0 5270.2 5557.2 21070.5 21339.9 21564.2 22316.7 22325.8 21193.6 21728.9 21734.0 21903.9 21963.6 10954.5 11163.8 11272.4 11537.8 11647.5 8637.9 8733.0 8813.9 8867.3 8902.4 18203.4 18795.2 18891.4 19280.1 19522.8 19538.1 19561.0 19677.7 19678.8 19800.0 11182.3 11348.9 11354.7 11364.0 11367.2 13846.5 14016.8 14162.9 14177.4 14186.9 11281.9 11377.5 11787.5 11853.6 11923.1 11324.4 11346.5 11392.7 11422.7 11690.6 10107.5 10144.2 10147.3 10194.4 10211.9 7237.3 7378.3 7412.3 7443.4 7503.0 7559.9 7741.9 7742.6 7765.1 7804.6 03:40:07 INFO - PID 3776 | 03:40:07 INFO - PID 3776 | [#4] prototype.html Cycles:180 Average:5431.96 Median:6095.78 stddev:1510.82 (24.8%) stddev-sans-first:1469.00 03:40:07 INFO - PID 3776 | Values: 499.6 501.5 529.7 529.7 535.9 6245.5 6287.8 6290.5 6306.4 6319.4 6180.6 6193.8 6221.6 6230.2 6288.7 5142.5 5143.9 5144.2 5156.0 5175.1 5075.2 5166.9 5186.7 5188.1 5189.7 4798.2 4891.9 4918.2 4954.2 5043.3 4859.5 4928.3 4940.2 4965.4 4989.4 4339.7 4399.4 4410.7 4471.0 4484.8 5831.7 5972.8 5986.2 6006.0 6027.2 5564.3 5570.7 5615.6 5650.2 5665.6 6356.5 6475.4 6478.3 6479.0 6502.1 4552.0 4792.8 4800.6 4814.1 4840.8 6593.3 6634.2 6794.3 6797.7 6810.7 4963.2 4982.8 4989.8 4991.3 5013.7 4960.6 4993.4 5007.4 5013.3 5027.6 5512.9 5625.7 5641.9 5642.7 5688.8 6504.6 6567.8 6585.3 6589.9 6592.2 1725.3 1726.7 1739.0 1745.4 1745.5 1126.3 1198.8 1207.9 1208.6 1214.4 5560.9 5604.8 5617.4 5641.7 5649.8 6489.5 6596.0 6604.3 6620.5 6623.3 5560.6 5589.7 5600.4 5630.5 5642.2 3402.4 3436.8 3452.8 3505.6 3528.6 6426.6 6472.1 6479.4 6494.2 6526.2 6734.0 6737.7 6753.7 6790.8 6857.2 6353.5 6377.8 6388.6 6406.6 6495.1 5969.0 6474.9 6501.2 6503.5 6541.8 6286.7 6353.8 6385.9 6470.3 6480.8 6325.4 6364.9 6368.3 6395.7 6399.8 4867.8 4909.2 4931.4 4956.6 4956.9 6294.9 6365.2 6541.1 6618.3 6640.7 6226.0 6311.1 6377.6 6441.6 6448.5 6425.3 6425.6 6427.9 6467.7 6496.9 6262.8 6268.6 6311.5 6365.8 6393.5 6338.8 6368.9 6392.3 6403.9 6518.4 6164.3 6194.4 6270.6 6281.7 6346.2 03:40:07 INFO - PID 3776 | 03:40:07 INFO - PID 3776 | [#5] yui.html Cycles:180 Average:23773.52 Median:18210.32 stddev:34226.14 (187.9%) stddev-sans-first:34279.01 03:40:07 INFO - PID 3776 | Values: 885.3 896.6 899.9 906.1 934.2 17222.9 17816.7 17818.3 17865.1 17952.4 17419.7 17470.0 17500.7 17756.0 17757.8 920.5 939.9 945.2 946.1 954.1 973.8 975.1 979.5 985.2 986.3 1032.0 1033.8 1034.7 1035.0 1035.5 1004.2 1032.9 1039.1 1043.1 1043.6 746.1 746.8 747.2 748.6 748.9 18789.1 18910.6 18998.0 19518.9 20192.2 20514.7 20626.6 20904.8 20939.7 20980.0 17807.9 18155.5 18207.6 18213.0 18219.8 3454.9 3614.3 3658.0 3685.9 3690.9 104761.0 105509.0 134114.0 138878.0 142573.0 17850.6 17974.2 18051.8 18228.5 18317.1 31314.2 31712.7 31758.0 31785.7 32306.4 9106.0 9158.0 9172.8 9193.2 9238.4 4218.5 4355.2 4367.6 4378.8 4394.0 5379.9 5476.4 5480.3 5540.4 5570.7 1015.4 1033.8 1055.1 1056.3 1059.2 649.1 662.3 672.6 681.7 687.7 11524.6 11548.2 11589.8 12084.6 12098.2 676.3 678.7 683.2 694.2 695.2 5484.4 5492.9 5518.5 5579.2 5610.9 117847.0 120129.0 122659.0 123553.0 124578.4 107860.5 108356.5 111302.0 111394.4 111527.4 93766.5 95058.0 96037.5 97968.0 98478.0 10104.7 10170.5 10263.9 10266.0 10275.9 41292.6 42312.0 42659.6 43006.6 43902.8 56012.4 56597.0 57831.7 57903.7 58991.0 14640.2 14653.5 14693.4 14708.3 14793.0 16442.1 16603.8 16627.4 16643.8 16664.2 14706.9 14746.9 14822.0 14991.3 15002.8 15742.0 15752.8 15777.6 15800.0 16068.6 15405.2 15472.5 15519.1 15581.1 15728.1 11130.2 11423.1 11536.8 11548.5 11674.3 11679.4 11737.8 11931.9 12134.4 12187.8 03:40:07 INFO - PID 3776 | -------- Summary: end -------- 03:40:07 INFO - PID 3776 | 03:40:08 INFO - TEST-INFO | 3776: exit 0 03:40:08 INFO - TEST-OK | dromaeo_css | took 1113091ms 03:40:08 INFO - TEST-START | kraken 03:40:08 INFO - Initialising browser for kraken test... 03:40:08 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:44055/getInfo.html -profile /tmp/tmpcBDEGU/profile 03:40:08 INFO - TEST-INFO | started process 4159 (/builds/slave/test/build/application/firefox/firefox http://localhost:44055/getInfo.html) 03:40:14 INFO - TEST-INFO | 4159: exit 0 03:40:14 INFO - Browser initialized. 03:40:14 INFO - Running cycle 1/1 for kraken test... 03:40:14 INFO - Using env: {'DISPLAY': ':0', 03:40:14 INFO - 'HOME': '/home/cltbld', 03:40:14 INFO - 'JSGC_DISABLE_POISONING': '1', 03:40:14 INFO - 'LANG': 'en_US.UTF-8', 03:40:14 INFO - 'LANGUAGE': 'en_US:en', 03:40:14 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 03:40:14 INFO - 'LOGNAME': 'cltbld', 03:40:14 INFO - 'MAIL': '/var/mail/cltbld', 03:40:14 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:40:14 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:40:14 INFO - 'MOZ_ACCELERATED': '1', 03:40:14 INFO - 'MOZ_CRASHREPORTER': '1', 03:40:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:40:14 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 03:40:14 INFO - 'MOZ_NO_REMOTE': '1', 03:40:14 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:40:14 INFO - 'MOZ_WEBRENDER': '1', 03:40:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:40:14 INFO - 'NO_EM_RESTART': '1', 03:40:14 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:40:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:40:14 INFO - 'PWD': '/builds/slave/test', 03:40:14 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:40:14 INFO - 'RUST_BACKTRACE': 'full', 03:40:14 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 03:40:14 INFO - 'SHELL': '/bin/bash', 03:40:14 INFO - 'SHLVL': '1', 03:40:14 INFO - 'TERM': 'linux', 03:40:14 INFO - 'TMOUT': '86400', 03:40:14 INFO - 'USER': 'cltbld', 03:40:14 INFO - 'XDG_SESSION_COOKIE': '20e20d796406ba5117c4a6f1000001ba-1505728237.436665-1436425885', 03:40:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:40:14 INFO - '_': '/tools/buildbot/bin/python'} 03:40:14 INFO - TEST-INFO | started process 4404 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpcBDEGU/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 03:40:14 INFO - PID 4404 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 03:40:15 INFO - PID 4404 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 03:40:15 INFO - PID 4404 | 03:40:15 INFO - PID 4404 | (/builds/slave/test/build/application/firefox/firefox:4463): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 03:40:15 INFO - PID 4404 | 03:40:25 INFO - PID 4404 | RSS: Main: 191823872 03:40:25 INFO - PID 4404 | 03:40:28 INFO - PID 4404 | Cycle 1(1): loaded http://localhost:44055/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44055/tests/kraken/driver.html?testName=audio-beat-detection) 03:40:29 INFO - PID 4404 | RSS: Main: 189861888 03:40:29 INFO - PID 4404 | 03:40:32 INFO - PID 4404 | Cycle 1(1): loaded http://localhost:44055/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44055/tests/kraken/driver.html?testName=audio-dft) 03:40:32 INFO - PID 4404 | RSS: Main: 189898752 03:40:32 INFO - PID 4404 | 03:40:35 INFO - PID 4404 | Cycle 1(1): loaded http://localhost:44055/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44055/tests/kraken/driver.html?testName=audio-fft) 03:40:36 INFO - PID 4404 | RSS: Main: 186494976 03:40:36 INFO - PID 4404 | 03:40:38 INFO - PID 4404 | Cycle 1(1): loaded http://localhost:44055/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44055/tests/kraken/driver.html?testName=audio-oscillator) 03:40:39 INFO - PID 4404 | RSS: Main: 187940864 03:40:39 INFO - PID 4404 | 03:40:41 INFO - PID 4404 | Cycle 1(1): loaded http://localhost:44055/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44055/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:40:41 INFO - PID 4404 | RSS: Main: 186986496 03:40:41 INFO - PID 4404 | 03:40:45 INFO - PID 4404 | Cycle 1(1): loaded http://localhost:44055/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44055/tests/kraken/driver.html?testName=imaging-darkroom) 03:40:45 INFO - PID 4404 | RSS: Main: 190083072 03:40:45 INFO - PID 4404 | 03:40:49 INFO - PID 4404 | Cycle 1(1): loaded http://localhost:44055/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44055/tests/kraken/driver.html?testName=imaging-desaturate) 03:40:50 INFO - PID 4404 | RSS: Main: 189566976 03:40:50 INFO - PID 4404 | 03:40:53 INFO - PID 4404 | Cycle 1(1): loaded http://localhost:44055/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44055/tests/kraken/driver.html?testName=json-parse-financial) 03:40:53 INFO - PID 4404 | RSS: Main: 189210624 03:40:53 INFO - PID 4404 | 03:40:55 INFO - PID 4404 | Cycle 1(1): loaded http://localhost:44055/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44055/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:40:55 INFO - PID 4404 | RSS: Main: 189599744 03:40:55 INFO - PID 4404 | 03:40:57 INFO - PID 4404 | Cycle 1(1): loaded http://localhost:44055/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44055/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:40:58 INFO - PID 4404 | RSS: Main: 187187200 03:40:58 INFO - PID 4404 | 03:41:00 INFO - PID 4404 | Cycle 1(1): loaded http://localhost:44055/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44055/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:41:01 INFO - PID 4404 | RSS: Main: 187043840 03:41:01 INFO - PID 4404 | 03:41:03 INFO - PID 4404 | Cycle 1(1): loaded http://localhost:44055/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44055/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:41:04 INFO - PID 4404 | RSS: Main: 186408960 03:41:04 INFO - PID 4404 | 03:41:07 INFO - PID 4404 | Cycle 1(1): loaded http://localhost:44055/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44055/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:41:07 INFO - PID 4404 | RSS: Main: 186593280 03:41:07 INFO - PID 4404 | 03:41:09 INFO - PID 4404 | Cycle 1(1): loaded http://localhost:44055/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44055/tests/kraken/driver.html?testName=ai-astar) 03:41:09 INFO - PID 4404 | RSS: Main: 189304832 03:41:09 INFO - PID 4404 | 03:41:09 INFO - PID 4404 | __start_tp_report 03:41:09 INFO - PID 4404 | _x_x_mozilla_page_load 03:41:09 INFO - PID 4404 | _x_x_mozilla_page_load_details 03:41:09 INFO - PID 4404 | |i|pagename|runs| 03:41:09 INFO - PID 4404 | |0;ai-astar;115;111;111;119;110;110;110;108;115;110 03:41:09 INFO - PID 4404 | |1;audio-beat-detection;128;122;117;119;116;154;123;120;126;123 03:41:09 INFO - PID 4404 | |2;audio-dft;168;177;165;163;169;163;164;161;162;164 03:41:09 INFO - PID 4404 | |3;audio-fft;82;82;80;75;72;78;75;82;78;74 03:41:09 INFO - PID 4404 | |4;audio-oscillator;82;81;87;86;84;123;86;85;81;79 03:41:09 INFO - PID 4404 | |5;imaging-gaussian-blur;114;120;114;115;114;118;116;116;122;117 03:41:09 INFO - PID 4404 | |6;imaging-darkroom;154;149;159;149;148;154;161;158;149;151 03:41:10 INFO - PID 4404 | |7;imaging-desaturate;100;94;95;94;94;100;95;94;94;94 03:41:10 INFO - PID 4404 | |8;json-parse-financial;53;55;49;54;53;54;54;56;59;53 03:41:10 INFO - PID 4404 | |9;json-stringify-tinderbox;45;42;40;39;45;40;45;38;38;38 03:41:10 INFO - PID 4404 | |10;stanford-crypto-aes;74;88;73;85;81;78;85;79;85;75 03:41:10 INFO - PID 4404 | |11;stanford-crypto-ccm;125;117;115;119;119;116;113;115;115;109 03:41:10 INFO - PID 4404 | |12;stanford-crypto-pbkdf2;169;164;167;164;179;171;173;166;166;165 03:41:10 INFO - PID 4404 | |13;stanford-crypto-sha256-iterative;68;74;66;65;68;66;63;66;65;65 03:41:10 INFO - PID 4404 | __end_tp_report 03:41:10 INFO - PID 4404 | __start_cc_report 03:41:10 INFO - PID 4404 | _x_x_mozilla_cycle_collect,728 03:41:10 INFO - PID 4404 | __end_cc_report 03:41:10 INFO - PID 4404 | __startTimestamp1505731269992__endTimestamp 03:41:10 INFO - PID 4404 | 03:41:10 INFO - PID 4404 | ------- Summary: start ------- 03:41:10 INFO - PID 4404 | Number of tests: 14 03:41:10 INFO - PID 4404 | 03:41:10 INFO - PID 4404 | [#0] ai-astar Cycles:10 Average:111.90 Median:111.00 stddev:3.35 (3.0%) stddev-sans-first:3.36 03:41:10 INFO - PID 4404 | Values: 115.0 111.0 111.0 119.0 110.0 110.0 110.0 108.0 115.0 110.0 03:41:10 INFO - PID 4404 | 03:41:10 INFO - PID 4404 | [#1] audio-beat-detection Cycles:10 Average:124.80 Median:123.00 stddev:10.92 (8.9%) stddev-sans-first:11.52 03:41:10 INFO - PID 4404 | Values: 128.0 122.0 117.0 119.0 116.0 154.0 123.0 120.0 126.0 123.0 03:41:10 INFO - PID 4404 | 03:41:10 INFO - PID 4404 | [#2] audio-dft Cycles:10 Average:165.60 Median:164.50 stddev:4.72 (2.9%) stddev-sans-first:4.92 03:41:10 INFO - PID 4404 | Values: 168.0 177.0 165.0 163.0 169.0 163.0 164.0 161.0 162.0 164.0 03:41:10 INFO - PID 4404 | 03:41:10 INFO - PID 4404 | [#3] audio-fft Cycles:10 Average:77.80 Median:79.00 stddev:3.68 (4.7%) stddev-sans-first:3.57 03:41:10 INFO - PID 4404 | Values: 82.0 82.0 80.0 75.0 72.0 78.0 75.0 82.0 78.0 74.0 03:41:10 INFO - PID 4404 | 03:41:10 INFO - PID 4404 | [#4] audio-oscillator Cycles:10 Average:87.40 Median:84.50 stddev:12.78 (15.1%) stddev-sans-first:13.41 03:41:10 INFO - PID 4404 | Values: 82.0 81.0 87.0 86.0 84.0 123.0 86.0 85.0 81.0 79.0 03:41:10 INFO - PID 4404 | 03:41:10 INFO - PID 4404 | [#5] imaging-gaussian-blur Cycles:10 Average:116.60 Median:116.50 stddev:2.72 (2.3%) stddev-sans-first:2.71 03:41:10 INFO - PID 4404 | Values: 114.0 120.0 114.0 115.0 114.0 118.0 116.0 116.0 122.0 117.0 03:41:10 INFO - PID 4404 | 03:41:10 INFO - PID 4404 | [#6] imaging-darkroom Cycles:10 Average:153.20 Median:154.00 stddev:4.76 (3.1%) stddev-sans-first:5.04 03:41:10 INFO - PID 4404 | Values: 154.0 149.0 159.0 149.0 148.0 154.0 161.0 158.0 149.0 151.0 03:41:10 INFO - PID 4404 | 03:41:10 INFO - PID 4404 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:94.00 stddev:2.46 (2.6%) stddev-sans-first:1.96 03:41:10 INFO - PID 4404 | Values: 100.0 94.0 95.0 94.0 94.0 100.0 95.0 94.0 94.0 94.0 03:41:10 INFO - PID 4404 | 03:41:10 INFO - PID 4404 | [#8] json-parse-financial Cycles:10 Average:54.00 Median:54.00 stddev:2.54 (4.7%) stddev-sans-first:2.67 03:41:10 INFO - PID 4404 | Values: 53.0 55.0 49.0 54.0 53.0 54.0 54.0 56.0 59.0 53.0 03:41:10 INFO - PID 4404 | 03:41:10 INFO - PID 4404 | [#9] json-stringify-tinderbox Cycles:10 Average:41.00 Median:41.00 stddev:3.02 (7.4%) stddev-sans-first:2.83 03:41:10 INFO - PID 4404 | Values: 45.0 42.0 40.0 39.0 45.0 40.0 45.0 38.0 38.0 38.0 03:41:10 INFO - PID 4404 | 03:41:10 INFO - PID 4404 | [#10] stanford-crypto-aes Cycles:10 Average:80.30 Median:83.00 stddev:5.31 (6.4%) stddev-sans-first:5.12 03:41:10 INFO - PID 4404 | Values: 74.0 88.0 73.0 85.0 81.0 78.0 85.0 79.0 85.0 75.0 03:41:10 INFO - PID 4404 | 03:41:10 INFO - PID 4404 | [#11] stanford-crypto-ccm Cycles:10 Average:116.30 Median:116.50 stddev:4.22 (3.6%) stddev-sans-first:3.08 03:41:10 INFO - PID 4404 | Values: 125.0 117.0 115.0 119.0 119.0 116.0 113.0 115.0 115.0 109.0 03:41:10 INFO - PID 4404 | 03:41:10 INFO - PID 4404 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:168.40 Median:168.00 stddev:4.77 (2.8%) stddev-sans-first:5.05 03:41:10 INFO - PID 4404 | Values: 169.0 164.0 167.0 164.0 179.0 171.0 173.0 166.0 166.0 165.0 03:41:10 INFO - PID 4404 | 03:41:10 INFO - PID 4404 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.60 Median:66.00 stddev:2.99 (4.5%) stddev-sans-first:3.13 03:41:10 INFO - PID 4404 | Values: 68.0 74.0 66.0 65.0 68.0 66.0 63.0 66.0 65.0 65.0 03:41:10 INFO - PID 4404 | -------- Summary: end -------- 03:41:10 INFO - PID 4404 | 03:41:10 INFO - PID 4404 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 03:41:10 INFO - TEST-INFO | 4404: exit 0 03:41:10 INFO - TEST-OK | kraken | took 62351ms 03:41:10 INFO - SUITE-END | took 1175s 03:41:11 INFO - Completed test suite (00:19:35) 03:41:11 INFO - javascript benchmark 03:41:11 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8406.245520629353, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3095.5047192449206, 3110.8911188108423, 3171.3498732759786, 3172.50826121951, 3173.825439600821, 6119.449249567538, 6287.15123458333, 6300.716467758951, 6312.305646378901, 6327.7785277515295, 6160.26076870775, 6216.720247588858, 6222.253329600454, 6246.84382890428, 6257.342978987209, 5691.117876729093, 5711.371749107595, 5718.513926316268, 5765.250517432749, 5785.942140578603, 5815.680137592431, 5817.7963771267805, 5832.737526811304, 5842.64944103353, 5855.209546711182, 5737.397573254811, 5785.363610002896, 5814.069748840187, 5829.387914268983, 5829.650220986754, 5567.331920169565, 5634.746436410372, 5636.351819540764, 5757.078867381219, 5879.1475236090955, 5685.260916080924, 5716.28546431696, 5739.225204597367, 5795.855103622401, 5796.5362770978645, 6103.87792244157, 6197.225346831601, 6209.3790620938, 6313.558050936436, 6325.968370158166, 6631.502637302222, 6635.635040072794, 6668.86662266752, 6676.365745254193, 6747.426468750162, 6700.664966751643, 6774.729010839561, 6784.525083244175, 6814.48891333147, 6819.727210911557, 6212.0, 6283.465905398047, 6314.93685063148, 6332.366763323676, 6345.777897773602, 6769.356911093439, 6888.621125838127, 6934.826629334307, 6956.826079348057, 6986.0, 6333.493320534346, 6511.641859697762, 6523.347665233438, 6556.967215163893, 6684.766033188815, 6557.147570815763, 6574.704138313788, 6617.205935287796, 6639.900401493981, 6668.266490686117, 6643.5017373697165, 6647.66761661915, 6662.133922590032, 6698.263191048981, 6708.127943367429, 6633.734650613921, 6655.900161497581, 6659.300773418819, 6755.729770809211, 6764.458843292525, 5135.768890399941, 5243.632945693841, 5274.762635681327, 5294.894102117936, 5315.787368505294, 4569.451665800125, 4635.374224479652, 4666.87994881226, 4670.042641258534, 4721.6458765592715, 5772.769089236467, 5778.335491418541, 5815.709214539256, 5819.243498345273, 5836.0, 6678.232003319583, 6736.191657001191, 6782.423494002966, 6813.557118787263, 6816.250212476623, 5744.770209191669, 5763.740631671585, 5850.64896106235, 5853.239078919798, 5861.0, 5646.2377579027125, 5715.399883012307, 5734.971325143348, 5754.309482862, 5799.5650326225705, 6512.934870651327, 6529.151210342625, 6564.8358791030605, 6600.768973085919, 6609.074729537869, 6657.3342665733035, 6695.598264104169, 6728.158980127484, 6796.150481189851, 6802.761903333359, 6507.479401647762, 6536.346365363425, 6569.113169722026, 6585.901211481927, 6630.867382652416, 6450.8064758057335, 6578.901316480353, 6580.80257592273, 6633.1376920999965, 6750.189977202767, 6658.533902626769, 6677.632730199885, 6680.0, 6691.297413771484, 6723.7646682365885, 6432.517561182836, 6509.02364645307, 6528.37980391862, 6546.574472659262, 6550.705218265094, 6402.711877965409, 6522.5760325578685, 6533.118029066015, 6564.8358791028695, 6565.179352580927, 6414.134091897721, 6436.8390790230615, 6517.576357536745, 6530.47756179514, 6539.280679125388, 6354.078658594571, 6426.068220108152, 6512.381323774234, 6551.21385433751, 6590.934090659032, 6328.46208072319, 6343.841403964938, 6349.174607301022, 6356.650384228912, 6390.680465976589], "value": 6106.730495747476, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [791.4736700094437, 807.2694211738371, 819.4386845011171, 821.392169794352, 826.2316046077145, 37353.81323093384, 38011.42982855256, 38158.23683526328, 40134.19731605366, 40730.7963460183, 38685.41971870417, 38833.611663883356, 38959.41560876589, 38992.80503597478, 39078.21843563127, 6983.895241571355, 7001.649917504117, 7090.50366474347, 7107.538010029358, 7123.180834204055, 6910.619915904648, 7657.234276572354, 7780.14418413974, 7795.493292935969, 7848.803779905491, 7780.727674531393, 7809.960950195241, 7813.570253636048, 7814.765557033298, 7829.843403131962, 7692.3461505772075, 7719.8070048248965, 7767.8058048548955, 7778.455508114434, 7880.999999999943, 7710.653020614086, 7727.034120734908, 7758.185390533969, 7765.339946104588, 7774.378049756063, 37444.0, 37768.0, 37776.244475110616, 37828.43257351142, 37839.054023649354, 3519.4017017107153, 3524.013276282645, 3525.982370088159, 3530.1704099536587, 3555.1112221944513, 31637.84181079103, 31656.208594785083, 31685.0, 31686.683133168604, 31789.0, 5098.7705553249825, 5102.438731739506, 5134.332536770196, 5171.663841850268, 5173.767180476888, 182715.0, 183482.0, 183986.0, 183997.0, 184143.0, 47418.525814742105, 47812.760936195795, 48080.0, 48115.27827082597, 48165.27752083722, 43882.0, 44967.0, 49478.50521494811, 51168.74415627898, 51203.48796511987, 14812.70374592502, 15024.624384390478, 15066.472673456376, 15095.245237738069, 15153.621159471102, 11593.710157246136, 11639.0, 11644.708882278012, 11663.533458661728, 11696.824547631792, 14456.710865782836, 14484.637884052772, 14523.709525809425, 14742.11547307165, 14896.180710061051, 5839.9124013139835, 5857.297124345106, 5867.589268751147, 5989.251343582052, 6033.818985430444, 989.3124278626285, 992.8212921674168, 1017.4048181813722, 1019.9898001020043, 1021.7343490692474, 24042.278731638078, 24187.879060604584, 24206.273811785675, 24317.036579226904, 24404.87797561001, 1103.906167975715, 1110.4114819145866, 1115.1524841120806, 1118.3401792942202, 1124.6232512108536, 12518.37408129608, 12527.812082818766, 12533.498660053678, 12576.559820406243, 12584.685382865318, 223744.0, 224785.0, 224787.0, 225344.0, 227453.0, 47673.28490072652, 47683.284750728766, 47825.043499129824, 47836.5216347839, 47903.5209647906, 1417.078898715843, 1459.37246983798, 1479.142097583399, 1485.1534625263496, 1495.0954672423245, 22628.66057009113, 22824.429389264737, 22828.4292892679, 23222.88388558114, 23572.52854942926, 32759.508607371386, 34067.65932340645, 36716.26567468689, 36721.26557468889, 36767.08082297857, 190017.0, 194138.0, 198371.0, 198782.0, 201659.0, 29780.55329170021, 32067.198320042186, 33297.0, 33413.83293083519, 33496.66503334935, 42135.7893210532, 42327.78836105923, 42382.78808605937, 42580.0, 42880.0, 31578.210544736565, 31590.842045789625, 31873.840630796698, 31910.0, 32752.67247327496, 31400.842995784875, 31713.5242971351, 31723.682763172998, 31737.0, 31874.84062579672, 34796.0, 34839.30321393609, 35060.12349691176, 35526.64473355337, 35586.64413355833, 30869.536956946115, 30902.84548577243, 31140.22149446282, 31140.68859311378, 31379.05862824119, 23523.0, 23638.29085127449, 23664.053437862294, 24106.51786964286, 24165.75834241635], "value": 16823.493707204812, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [568.1647977473114, 569.9430056994298, 573.8766165274468, 578.7424596054755, 581.1979468333699, 21732.565348693017, 22421.0, 22423.878806059714, 22480.213192538264, 22669.09323627057, 22693.319200424015, 23841.403964900885, 24096.397590060213, 24137.15519956802, 24250.393740156505, 6333.999999999988, 6466.838329041788, 6477.740890364404, 6515.837104072389, 6521.413072823445, 6430.260520040185, 6434.420902118808, 6453.709583068773, 6500.154979852636, 6509.056186852904, 6125.693715314239, 6349.42855143037, 6447.516436267275, 6455.2576453707725, 6481.125048118491, 6388.39310265524, 6469.838254043663, 6481.999999999976, 6497.025446183063, 6504.219493660744, 5877.089051197071, 5997.430244126845, 6035.275766907999, 6052.364501727299, 6150.50795936324, 27873.860630696716, 28384.0, 28418.431631367257, 28464.857675711697, 28476.28809279764, 2002.5193953451067, 2023.8886861222627, 2024.5647185855112, 2025.0381068992258, 2025.1595587831032, 18292.908535457238, 18760.62478750431, 19041.238350465967, 19136.712949305773, 19164.61670766577, 2325.174563030117, 2396.209250947183, 2396.844205126661, 2397.3527147670206, 2440.5362981033722, 114232.0, 123360.38319808434, 123781.0, 131384.0, 131944.99999999904, 14015.229162395963, 14290.78528325104, 14368.497102601359, 14642.780358294634, 14834.184119873295, 22254.777452225593, 22287.331380058626, 22341.218057367914, 22355.441113971956, 22480.662790058162, 9026.684066057656, 9287.953560232156, 9313.0, 9362.90637093634, 9364.531773411438, 8333.999840038468, 8377.832443351099, 8415.789605259917, 8495.405321627426, 8564.52895090776, 8914.777130571787, 8945.958374152819, 8954.2836573074, 8979.77550561228, 9124.406913550598, 2725.9927905978575, 2744.2590500564734, 2750.3811642380706, 2753.2290958531644, 2811.4377124575167, 958.7363475044418, 972.6060945317158, 976.8827740671023, 981.6711401680374, 984.7538115471132, 18218.45344639663, 18340.174692138884, 18457.70796044291, 18566.350177743716, 18839.81160188408, 1027.106417416852, 1027.9258175206926, 1033.6278939581744, 1038.200585549123, 1039.7244730146517, 10319.0, 10336.224783141295, 10498.800479807986, 10511.369317840954, 10648.467576621293, 504760.0, 508299.0, 515310.0, 515383.0, 515979.0, 105831.0, 107838.46080769546, 108220.0, 108658.0, 109091.0, 1167.976640467203, 1178.5816035307341, 1212.8956260887353, 1212.9878701213051, 1213.4478812140455, 16831.41090061842, 16931.153442327588, 16985.006778850067, 17117.972921624743, 17340.0, 54133.646658833844, 57113.71443142758, 57309.0, 57314.0, 58141.0, 69922.65038674774, 70029.64985175042, 70748.29251707623, 70848.0, 71816.64091679508, 13746.381412836647, 13761.17432954026, 13783.173009619455, 13802.102863313852, 13857.861421385656, 18398.81601183971, 20799.68800467964, 21666.133354665635, 21693.891530542878, 22082.779172208073, 17390.73913891318, 17542.561435963693, 17746.91126544359, 17821.376251831123, 17891.19489622944, 15375.538733838002, 15558.377664893278, 16211.189440528162, 16265.186740663155, 16393.0, 17579.384721534683, 17784.55538611545, 17871.910640446713, 17875.37436189727, 17951.640967180323, 13219.801702974655, 13441.059125861488, 13565.186088834702, 13608.727825443633, 13615.18308901469, 16865.0, 16969.915150424167, 16979.405720799714, 17081.0, 17144.057076860394], "value": 11566.326569605088, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1340.6782372230664, 1407.3948202273025, 1411.4565892131527, 1423.2527922840502, 1430.7353139669162, 14850.33173507192, 15168.241587920602, 15724.135172565504, 16222.675546489063, 16245.918770406131, 15816.604584885383, 16049.91975040126, 16109.113998730065, 16151.757723634155, 16172.27224774885, 2771.4041481081613, 2821.3510892494737, 2834.3055951291963, 2835.0, 2838.8154769939993, 2683.6511253537014, 2879.9856000719965, 2907.8546072696386, 2924.722151395614, 2927.736503714665, 2799.986000070007, 2807.143821134553, 2849.843258620775, 2850.401415702705, 2853.144056782957, 2799.0, 2811.3533887205954, 2834.3906060197055, 2835.53213719736, 2839.063109173968, 2705.594160875865, 2714.647095877543, 2715.2125883493763, 2723.0, 2723.6459260296033, 15114.319855606524, 15118.319675614624, 15173.468928587446, 15264.771028434583, 15323.31045102973, 7988.480748751371, 8322.334213262924, 8353.164683531659, 8367.330613550963, 8368.3305335573, 5380.542653874425, 5534.861628459281, 5636.71816409182, 5724.084146536534, 5782.653040817522, 1889.1309997401213, 1895.876768010075, 1907.1799126375654, 1945.9318923837739, 1953.6385768632706, 26664.0, 26681.866590667116, 26776.464470710478, 26978.325541861414, 27071.593926091125, 6644.601323920484, 6760.256371799098, 6867.759628412981, 6995.300469953066, 7044.0, 17480.737788933176, 17507.47477575675, 17602.735958960628, 17604.29582816673, 17619.735703964452, 7772.18392068836, 7950.0857401398425, 8173.754787356389, 8232.711855085163, 8238.50568965864, 7230.74692385764, 7236.3487286143445, 7337.41300695943, 7354.816129596803, 7377.594232317167, 5246.816361427332, 5318.25544423781, 5320.414754377015, 5381.354237491448, 5411.648242864201, 1556.3618916244286, 1559.1502631065869, 1561.9219039048003, 1565.6633823727952, 1597.7922870026823, 867.8524650809378, 869.9652013919373, 895.6238379880466, 897.3090720145582, 904.8552231642906, 7331.523450975669, 7367.115946086396, 7376.3730082942475, 7379.262073792578, 7415.629218539051, 720.5892641194573, 723.3815088099599, 724.6376811594203, 739.8113481062295, 745.4446437404168, 5084.9745751271, 5169.224616307584, 5211.973940130351, 5270.183121616155, 5557.166425036196, 21070.473238168863, 21339.89330053371, 21564.245251416127, 22316.665250021262, 22325.77674223237, 21193.576128477653, 21728.913554322222, 21734.0, 21903.890480547812, 21963.560728785335, 10954.452277386099, 11163.83254251187, 11272.436378181059, 11537.769244615229, 11647.53409863613, 8637.91362086371, 8733.0, 8813.91186088131, 8867.290616750774, 8902.42134261271, 18203.362882299058, 18795.154218059946, 18891.43325700231, 19280.132394042583, 19522.8047719521, 19538.120784564446, 19561.0, 19677.704834427208, 19678.803211967697, 19800.0, 11182.32906025641, 11348.943255283672, 11354.659360218877, 11364.0, 11367.20429569922, 13846.515371961934, 14016.789748153582, 14162.858371416567, 14177.362018708976, 14186.929065354607, 11281.943590281997, 11377.54489820398, 11787.528498859949, 11853.5851245206, 11923.10576706733, 11324.433778311217, 11346.489407976826, 11392.658220253406, 11422.657320280405, 11690.590829320932, 10107.49462526856, 10144.239182061523, 10147.289689721649, 10194.43930583825, 10211.948940255252, 7237.312455316736, 7378.29906158914, 7412.332890039922, 7443.441741869273, 7502.962485187539, 7559.886601701089, 7741.92258077412, 7742.6128693566225, 7765.145833958373, 7804.648790804314], "value": 6752.471348251666, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [499.56873557258444, 501.48347202381547, 529.6663102245585, 529.7483695244762, 535.9094243215059, 6245.469135123509, 6287.842803929904, 6290.49676025918, 6306.432421082101, 6319.368063193679, 6180.567360284782, 6193.814185574429, 6221.59559628625, 6230.190075290206, 6288.685565721718, 5142.485751424865, 5143.897122057557, 5144.17693169093, 5155.974220128895, 5175.094358487268, 5075.162598171298, 5166.896662066756, 5186.662866913657, 5188.066148093341, 5189.688618682872, 4798.160321943646, 4891.853244402673, 4918.1802732988845, 4954.232094025432, 5043.344365232515, 4859.465458799529, 4928.310036594879, 4940.184869496528, 4965.428975667808, 4989.3513843200335, 4339.7396156230725, 4399.428074350314, 4410.7429382626115, 4470.977645111753, 4484.798184081692, 5831.650100993954, 5972.761089556412, 5986.191864098378, 6006.039033754579, 6027.246594175728, 5564.3275438210585, 5570.738385135374, 5615.550755939515, 5650.208970744099, 5665.575081868835, 6356.459700925427, 6475.384838440341, 6478.319776423455, 6478.967605161991, 6502.089707440962, 4551.977240113812, 4792.832250871237, 4800.615950723934, 4814.109389762905, 4840.789802549362, 6593.307702691196, 6634.203895532519, 6794.286599907037, 6797.694103765342, 6810.659467026679, 4963.156263435225, 4982.77577509013, 4989.750512474362, 4991.326170966873, 5013.674111182761, 4960.578350840146, 4993.375828021497, 5007.4241462231585, 5013.298138260647, 5027.648064635514, 5512.91730624041, 5625.746841392147, 5641.8589535261945, 5642.689652069093, 5688.800891968761, 6504.642244676494, 6567.802965911031, 6585.275619681831, 6589.86820263592, 6592.208934927839, 1725.344369139744, 1726.697827880116, 1738.9913849966988, 1745.4327343613122, 1745.528707249061, 1126.3129491010477, 1198.8141838014947, 1207.9094067944939, 1208.6434501821984, 1214.3745970825032, 5560.916586251209, 5604.775808967595, 5617.438256174431, 5641.661500309994, 5649.774009039593, 6489.480841532666, 6595.967020164869, 6604.306547812506, 6620.536562440583, 6623.271440141581, 5560.610757247035, 5589.692566908778, 5600.383957764642, 5630.465105814941, 5642.235304700749, 3402.4045791986305, 3436.8453419596176, 3452.7928324300624, 3505.631908649606, 3528.5709287738505, 6426.550141490051, 6472.093906853044, 6479.384458476437, 6494.220693516714, 6526.216853977553, 6733.966330168318, 6737.6968036438475, 6753.729850806011, 6790.796276111724, 6857.245702972669, 6353.4599559038, 6377.808665740035, 6388.648624325707, 6406.615603063831, 6495.083950234692, 5968.970155149196, 6474.859693048962, 6501.2198536175965, 6503.544751867513, 6541.803745887631, 6286.705352546196, 6353.809385718436, 6385.936140638534, 6470.255920569195, 6480.837979050561, 6325.367463253638, 6364.886144924712, 6368.299487056327, 6395.744170233324, 6399.8080057598345, 4867.829625963216, 4909.239067944474, 4931.358923340086, 4956.613397143482, 4956.900861982812, 6294.905576416266, 6365.204349456318, 6541.149650545399, 6618.338166183343, 6640.734370625121, 6225.968870155621, 6311.116443697794, 6377.585456945284, 6441.645709485836, 6448.484121270381, 6425.261094974137, 6425.5502114851515, 6427.871442571216, 6467.741290348522, 6496.870062598816, 6262.843428914313, 6268.620903401426, 6311.526635502264, 6365.777197798055, 6393.474577541752, 6338.809835704937, 6368.936310636835, 6392.264889537577, 6403.903941440789, 6518.392642942861, 6164.321924588202, 6194.389458740669, 6270.561060725888, 6281.748730050746, 6346.20766862579], "value": 4988.579939053178, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [885.2873436883307, 896.556204678684, 899.8751560549305, 906.0758026812651, 934.191923985752, 17222.91388543057, 17816.732749008774, 17818.287268509277, 17865.10674466278, 17952.371666991658, 17419.651606967855, 17470.0, 17500.737488937677, 17756.023418711964, 17757.822421775778, 920.452330863137, 939.8778158839341, 945.2249155692335, 946.0539460539461, 954.1079091049855, 973.8052389522123, 975.0785507695231, 979.480875136179, 985.1675334342505, 986.2849434160248, 1031.9742006449862, 1033.8139134955704, 1034.689593122064, 1034.9793004139913, 1035.4822588705647, 1004.2267454060369, 1032.8554002439664, 1039.1167507618538, 1043.1133536493996, 1043.5877828257871, 746.1493896957472, 746.8058304840727, 747.249014740188, 748.6294284329238, 748.9063867016623, 18789.060546972596, 18910.62178756431, 18998.0, 19518.902405487883, 20192.19231230749, 20514.692279615818, 20626.58746825055, 20904.79095209059, 20939.68590471144, 20980.0, 17807.910960445246, 18155.54611134719, 18207.635847283113, 18213.0, 18219.817801821944, 3454.913627159316, 3614.3132804767274, 3658.0306218852024, 3685.94471082934, 3690.8892733218045, 104761.0, 105509.0, 134114.0, 138878.0, 142572.99999999895, 17850.5537361567, 17974.191161397506, 18051.819481805276, 18228.54428639268, 18317.084145792658, 31314.21714457157, 31712.682873171434, 31758.0, 31785.682143178274, 32306.35387292288, 9105.954470227607, 9158.0, 9172.770680733034, 9193.172614464731, 9238.445693258425, 4218.535961044283, 4355.216061108968, 4367.606915377632, 4378.78106094694, 4393.978030109829, 5379.919301210485, 5476.424975377608, 5480.342358916955, 5540.390557038722, 5570.6657600543285, 1015.3958394755109, 1033.7570670892335, 1055.1453322808395, 1056.2922841696081, 1059.163261023798, 649.1301655781276, 662.3244290823333, 672.6199697171082, 681.7375310505392, 687.6974131382176, 11524.59663911759, 11548.249363791327, 11589.768204636028, 12084.577039803564, 12098.153129281041, 676.3338111959715, 678.6708446403491, 683.2484267306023, 694.1565997313188, 695.151914664109, 5484.369297530755, 5492.862678433071, 5518.530924871431, 5579.218909352613, 5610.943890561124, 117847.0, 120129.0, 122659.0, 123553.0, 124578.37710811388, 107860.460697696, 108356.45821770841, 111302.0, 111394.44302778435, 111527.44236278767, 93766.53116734372, 95058.0, 96037.5198124019, 97968.0, 98478.0, 10104.69685909424, 10170.491475426346, 10263.94868025685, 10266.024727650862, 10275.948620256851, 41292.587074128875, 42312.0, 42659.57340426556, 43006.56993430151, 43902.78048609736, 56012.43987560235, 56597.0, 57831.71084144552, 57903.71048144732, 58991.0, 14640.194789286266, 14653.487127950471, 14693.412263509339, 14708.264586770832, 14793.0, 16442.095684737455, 16603.750943736097, 16627.418040368528, 16643.75034374461, 16664.166791660125, 14706.852931470976, 14746.926265368604, 14822.0, 14991.2504374783, 15002.774958375852, 15742.0, 15752.842471575137, 15777.605559861095, 15800.0, 16068.598285042968, 15405.152716600694, 15472.5358239253, 15519.068855868683, 15581.143037132613, 15728.134952577719, 11130.220884538005, 11423.086153107897, 11536.769264614828, 11548.538058477567, 11674.299542027506, 11679.357635330138, 11737.765244695229, 11931.880681193077, 12134.393280336124, 12187.756244874876], "value": 8815.099235573758, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1459.2999999999997, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 111.0, 111.0, 119.0, 110.0, 110.0, 110.0, 108.0, 115.0, 110.0], "value": 111.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [128.0, 122.0, 117.0, 119.0, 116.0, 154.0, 123.0, 120.0, 126.0, 123.0], "value": 124.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 177.0, 165.0, 163.0, 169.0, 163.0, 164.0, 161.0, 162.0, 164.0], "value": 165.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 80.0, 75.0, 72.0, 78.0, 75.0, 82.0, 78.0, 74.0], "value": 77.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 81.0, 87.0, 86.0, 84.0, 123.0, 86.0, 85.0, 81.0, 79.0], "value": 87.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 120.0, 114.0, 115.0, 114.0, 118.0, 116.0, 116.0, 122.0, 117.0], "value": 116.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 149.0, 159.0, 149.0, 148.0, 154.0, 161.0, 158.0, 149.0, 151.0], "value": 153.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 94.0, 95.0, 94.0, 94.0, 100.0, 95.0, 94.0, 94.0, 94.0], "value": 95.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 55.0, 49.0, 54.0, 53.0, 54.0, 54.0, 56.0, 59.0, 53.0], "value": 54.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [45.0, 42.0, 40.0, 39.0, 45.0, 40.0, 45.0, 38.0, 38.0, 38.0], "value": 41.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 88.0, 73.0, 85.0, 81.0, 78.0, 85.0, 79.0, 85.0, 75.0], "value": 80.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [125.0, 117.0, 115.0, 119.0, 119.0, 116.0, 113.0, 115.0, 115.0, 109.0], "value": 116.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 164.0, 167.0, 164.0, 179.0, 171.0, 173.0, 166.0, 166.0, 165.0], "value": 168.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 74.0, 66.0, 65.0, 68.0, 66.0, 63.0, 66.0, 65.0, 65.0], "value": 66.6, "unit": "score"}]}]} 03:41:11 INFO - Return code: 0 03:41:11 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:41:11 INFO - # TBPL SUCCESS # 03:41:11 INFO - Running post-action listener: _package_coverage_data 03:41:11 INFO - Running post-action listener: _resource_record_post_action 03:41:11 INFO - [mozharness: 2017-09-18 10:41:11.256737Z] Finished run-tests step (success) 03:41:11 INFO - Running post-run listener: _resource_record_post_run 03:41:11 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 4755456; Write bytes: 338456576; Read time: 1176; Write time: 216092 03:41:11 INFO - TinderboxPrint: CPU usage
13.2% 03:41:11 INFO - TinderboxPrint: I/O read bytes / time
4,755,456 / 1,176 03:41:11 INFO - TinderboxPrint: I/O write bytes / time
338,456,576 / 216,092 03:41:11 INFO - TinderboxPrint: CPU idle
8,253.2 (86.7%) 03:41:11 INFO - TinderboxPrint: CPU user
1,201.4 (12.6%) 03:41:11 INFO - TinderboxPrint: Swap in / out
0 / 0 03:41:11 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 13230080; Read time: 0; Write time: 1204 03:41:11 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:11 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 4751360; Write bytes: 325226496; Read time: 1168; Write time: 214888 03:41:11 INFO - Running post-run listener: _upload_blobber_files 03:41:11 INFO - Blob upload gear active. 03:41:11 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:41:11 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:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 03:41:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 03:41:12 INFO - (blobuploader) - INFO - Open directory for files ... 03:41:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 03:41:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:41:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:41:13 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 03:41:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:41:13 INFO - (blobuploader) - INFO - Done attempting. 03:41:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:41:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:41:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:41:20 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:41:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:41:20 INFO - (blobuploader) - INFO - Done attempting. 03:41:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:41:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:41:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:41:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:41:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:41:21 INFO - (blobuploader) - INFO - Done attempting. 03:41:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:41:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:41:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:41:22 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:41:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:41:22 INFO - (blobuploader) - INFO - Done attempting. 03:41:22 INFO - (blobuploader) - INFO - Iteration through files over. 03:41:22 INFO - Return code: 0 03:41:22 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:41:22 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:41:22 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/36e809e7c7a618b937ac10db15d669cbbf0eb6365674b398b95f6a04dcf3e947b6fc303eadeff95177603e54f791644e4bebf8b316fd6c46f3d56b4e73e78721", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/356be173d8d5c0b41a2abc918112e96c3d8a298423a66ee9316b2536710cd77e586e2576a68ad143b9d216c59d126053b77bb750c0e1ac2f59a08f12fac94856", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/01ce524ea00917ae50ff8344b86473d0466180d41ba1d84988c05e71643a36278c45e82c342e0f54bcca2b4a543d130f83f7a0b691031711e988eed5c2ab4137", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/dd43239cb1527896a92c94b07ecc0b7b52c68a669526127bdb8f3b96d5e250d3231d41dd7af026996f28f8982cf4a5d30dd26bc464acbdcc93e32a8027529227"} 03:41:22 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:41:22 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:41:22 INFO - Contents: 03:41:22 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/36e809e7c7a618b937ac10db15d669cbbf0eb6365674b398b95f6a04dcf3e947b6fc303eadeff95177603e54f791644e4bebf8b316fd6c46f3d56b4e73e78721", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/356be173d8d5c0b41a2abc918112e96c3d8a298423a66ee9316b2536710cd77e586e2576a68ad143b9d216c59d126053b77bb750c0e1ac2f59a08f12fac94856", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/01ce524ea00917ae50ff8344b86473d0466180d41ba1d84988c05e71643a36278c45e82c342e0f54bcca2b4a543d130f83f7a0b691031711e988eed5c2ab4137", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/dd43239cb1527896a92c94b07ecc0b7b52c68a669526127bdb8f3b96d5e250d3231d41dd7af026996f28f8982cf4a5d30dd26bc464acbdcc93e32a8027529227"} 03:41:22 INFO - Running post-run listener: copy_logs_to_upload_dir 03:41:22 INFO - Copying logs to upload dir... 03:41:22 INFO - mkdir: /builds/slave/test/build/upload/logs 03:41:22 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1243.749621 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2017-09-18 03:41:22.869801) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-18 03:41:22.878521) ========= 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=20e20d796406ba5117c4a6f1000001ba-1505728237.436665-1436425885 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/36e809e7c7a618b937ac10db15d669cbbf0eb6365674b398b95f6a04dcf3e947b6fc303eadeff95177603e54f791644e4bebf8b316fd6c46f3d56b4e73e78721", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/356be173d8d5c0b41a2abc918112e96c3d8a298423a66ee9316b2536710cd77e586e2576a68ad143b9d216c59d126053b77bb750c0e1ac2f59a08f12fac94856", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/01ce524ea00917ae50ff8344b86473d0466180d41ba1d84988c05e71643a36278c45e82c342e0f54bcca2b4a543d130f83f7a0b691031711e988eed5c2ab4137", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/dd43239cb1527896a92c94b07ecc0b7b52c68a669526127bdb8f3b96d5e250d3231d41dd7af026996f28f8982cf4a5d30dd26bc464acbdcc93e32a8027529227"} 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/sha512/36e809e7c7a618b937ac10db15d669cbbf0eb6365674b398b95f6a04dcf3e947b6fc303eadeff95177603e54f791644e4bebf8b316fd6c46f3d56b4e73e78721", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/356be173d8d5c0b41a2abc918112e96c3d8a298423a66ee9316b2536710cd77e586e2576a68ad143b9d216c59d126053b77bb750c0e1ac2f59a08f12fac94856", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/01ce524ea00917ae50ff8344b86473d0466180d41ba1d84988c05e71643a36278c45e82c342e0f54bcca2b4a543d130f83f7a0b691031711e988eed5c2ab4137", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/dd43239cb1527896a92c94b07ecc0b7b52c68a669526127bdb8f3b96d5e250d3231d41dd7af026996f28f8982cf4a5d30dd26bc464acbdcc93e32a8027529227"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-18 03:41:22.906815) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-18 03:41:22.911155) ========= 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=20e20d796406ba5117c4a6f1000001ba-1505728237.436665-1436425885 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004448 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-18 03:41:22.990974) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-18 03:41:22.993344) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-18 03:41:22.993667) ========= ========= Total master_lag: 0.25 =========