builder: mozilla-central_ubuntu64_hw_qr_test-dromaeojs-e10s slave: talos-linux64-ix-082 starttime: 1505372666.09 results: success (0) revision: 9517eea4a1a5955618fc79d039f9f0282b7185ca ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-14 00:04:26.091765) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-14 00:04:26.092322) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-14 00:04:26.092979) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-14 00:04:26.267632) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-14 00:04:26.271290) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=51fc86400edbde9650d2781a000001d0-1505370572.267818-213713610 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-14 00:04:26-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 33.0M=0s 2017-09-14 00:04:26 (33.0 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.136059 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-14 00:04:26.452162) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-14 00:04:26.452437) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=51fc86400edbde9650d2781a000001d0-1505370572.267818-213713610 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019315 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-14 00:04:26.502205) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 12 secs) (at 2017-09-14 00:04:26.502522) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 9517eea4a1a5955618fc79d039f9f0282b7185ca --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 9517eea4a1a5955618fc79d039f9f0282b7185ca --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=51fc86400edbde9650d2781a000001d0-1505370572.267818-213713610 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-14 00:04:26,532 truncating revision to first 12 chars 2017-09-14 00:04:26,532 Setting DEBUG logging. 2017-09-14 00:04:26,532 attempt 1/10 2017-09-14 00:04:26,532 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/9517eea4a1a5?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-14 00:04:26,928 attempt 1/10 2017-09-14 00:04:27,826 current task status: no status available at this point. state: STARTED 2017-09-14 00:04:27,827 sleeping for 10.00s (attempt 1/10) 2017-09-14 00:04:37,837 attempt 2/10 2017-09-14 00:04:38,198 current task status: Task completed! Check 's3_urls' for upload locations. state: SUCCESS 2017-09-14 00:04:38,383 unpacking tar archive at: mozilla-central-9517eea4a1a5/testing/mozharness/ program finished with exit code 0 elapsedTime=12.159604 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 12 secs) (at 2017-09-14 00:04:38.680015) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-14 00:04:38.680291) ========= script_repo_revision: 9517eea4a1a5955618fc79d039f9f0282b7185ca ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-14 00:04:38.683650) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-14 00:04:38.683934) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-14 00:04:38.696867) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2017-09-14 00:04:38.697138) ========= /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=51fc86400edbde9650d2781a000001d0-1505370572.267818-213713610 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 00:04:38 INFO - MultiFileLogger online at 20170914 00:04:38 in /builds/slave/test 00:04:38 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 00:04:38 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 00:04:38 INFO - {'append_to_log': False, 00:04:38 INFO - 'base_work_dir': '/builds/slave/test', 00:04:38 INFO - 'blob_upload_branch': 'Firefox', 00:04:38 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 00:04:38 INFO - 'branch': 'Firefox', 00:04:38 INFO - 'buildbot_json_path': 'buildprops.json', 00:04:38 INFO - 'code_coverage': False, 00:04:38 INFO - 'config_files': ('talos/linux_config.py',), 00:04:38 INFO - 'default_actions': ('clobber', 00:04:38 INFO - 'read-buildbot-config', 00:04:38 INFO - 'download-and-extract', 00:04:38 INFO - 'populate-webroot', 00:04:38 INFO - 'create-virtualenv', 00:04:38 INFO - 'install', 00:04:38 INFO - 'setup-mitmproxy', 00:04:38 INFO - 'run-tests'), 00:04:38 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 00:04:38 INFO - 'disable_ccov_upload': False, 00:04:38 INFO - 'disable_stylo': False, 00:04:38 INFO - 'download_minidump_stackwalk': True, 00:04:38 INFO - 'download_symbols': 'ondemand', 00:04:38 INFO - 'enable_stylo': False, 00:04:38 INFO - 'enable_webrender': False, 00:04:38 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 00:04:38 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 00:04:38 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 00:04:38 INFO - 'gecko_profile': False, 00:04:38 INFO - 'gecko_profile_interval': 0, 00:04:38 INFO - 'installer_path': 'installer.exe', 00:04:38 INFO - 'log_level': 'info', 00:04:38 INFO - 'log_name': 'talos', 00:04:38 INFO - 'log_to_console': True, 00:04:38 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 00:04:38 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 00:04:38 INFO - 'opt_config_files': (), 00:04:38 INFO - 'pip_index': False, 00:04:38 INFO - 'suite': 'dromaeojs-e10s', 00:04:38 INFO - 'system_bits': '32', 00:04:38 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 00:04:38 INFO - 'title': 'talos-linux64-ix-082', 00:04:38 INFO - 'tooltool_cache': '/builds/tooltool_cache', 00:04:38 INFO - 'use_talos_json': True, 00:04:38 INFO - 'verify': 'False', 00:04:38 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 00:04:38 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 00:04:38 INFO - 'work_dir': 'build'} 00:04:38 INFO - [mozharness: 2017-09-14 07:04:38.872339Z] Running clobber step. 00:04:38 INFO - Running pre-action listener: _resource_record_pre_action 00:04:38 INFO - Running main action method: clobber 00:04:38 INFO - rmtree: /builds/slave/test/build 00:04:38 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 00:04:40 INFO - Running post-action listener: _resource_record_post_action 00:04:40 INFO - [mozharness: 2017-09-14 07:04:40.391822Z] Finished clobber step (success) 00:04:40 INFO - [mozharness: 2017-09-14 07:04:40.391920Z] Running read-buildbot-config step. 00:04:40 INFO - Running pre-action listener: _resource_record_pre_action 00:04:40 INFO - Running main action method: read_buildbot_config 00:04:40 INFO - Using buildbot properties: 00:04:40 INFO - { 00:04:40 INFO - "project": "", 00:04:40 INFO - "product": "firefox", 00:04:40 INFO - "who": "kwierso@gmail.com", 00:04:40 INFO - "installer_path": "public/build/target.tar.bz2", 00:04:40 INFO - "builddir": "mozilla-central_ubuntu64_hw_qr_test-dromaeojs-e10s", 00:04:40 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 00:04:40 INFO - "buildername": "Ubuntu HW 12.04 x64 qr mozilla-central talos dromaeojs-e10s", 00:04:40 INFO - "stage_platform": "linux64-qr", 00:04:40 INFO - "basedir": "/builds/slave/test", 00:04:40 INFO - "buildnumber": 52, 00:04:40 INFO - "platform": "ubuntu64_hw_qr", 00:04:40 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 00:04:40 INFO - "slavebuilddir": "test", 00:04:40 INFO - "taskId": "TSXWS7aBQUmu8u73MwJEJg", 00:04:40 INFO - "branch": "mozilla-central", 00:04:40 INFO - "script_repo_revision": "production", 00:04:40 INFO - "revision": "9517eea4a1a5955618fc79d039f9f0282b7185ca", 00:04:40 INFO - "slavename": "talos-linux64-ix-082", 00:04:40 INFO - "repo_path": "mozilla-central" 00:04:40 INFO - } 00:04:40 INFO - Finding installer, test and symbols from parent task. 00:04:40 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/TSXWS7aBQUmu8u73MwJEJg'}, attempt #1 00:04:40 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/TSXWS7aBQUmu8u73MwJEJg'}, attempt #1 00:04:41 INFO - Task dependencies: XsUnDtePTKytTQbE-xS2cw 00:04:41 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/XsUnDtePTKytTQbE-xS2cw'}, attempt #1 00:04:41 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/XsUnDtePTKytTQbE-xS2cw/artifacts/public/build/target.tar.bz2 00:04:41 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/XsUnDtePTKytTQbE-xS2cw/artifacts/public/build/target.test_packages.json 00:04:41 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/XsUnDtePTKytTQbE-xS2cw/artifacts/public/build/target.crashreporter-symbols.zip 00:04:41 INFO - Running post-action listener: _resource_record_post_action 00:04:41 INFO - [mozharness: 2017-09-14 07:04:41.858719Z] Finished read-buildbot-config step (success) 00:04:41 INFO - [mozharness: 2017-09-14 07:04:41.858937Z] Running download-and-extract step. 00:04:41 INFO - Running pre-action listener: _resource_record_pre_action 00:04:41 INFO - Running main action method: download_and_extract 00:04:41 INFO - mkdir: /builds/slave/test/build/tests 00:04:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:04:41 INFO - trying https://queue.taskcluster.net/v1/task/XsUnDtePTKytTQbE-xS2cw/artifacts/public/build/target.test_packages.json 00:04:41 INFO - Downloading https://queue.taskcluster.net/v1/task/XsUnDtePTKytTQbE-xS2cw/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 00:04:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/XsUnDtePTKytTQbE-xS2cw/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 00:04:42 INFO - Downloaded 989 bytes. 00:04:42 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 00:04:42 INFO - Using the following test package requirements: 00:04:42 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 00:04:42 INFO - u'common': [u'target.common.tests.zip'], 00:04:42 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 00:04:42 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 00:04:42 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 00:04:42 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 00:04:42 INFO - u'mozbase': [u'target.common.tests.zip'], 00:04:42 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 00:04:42 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 00:04:42 INFO - u'web-platform': [u'target.common.tests.zip', 00:04:42 INFO - u'target.web-platform.tests.tar.gz'], 00:04:42 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 00:04:42 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 00:04:42 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/XsUnDtePTKytTQbE-xS2cw/artifacts/public/build/target.common.tests.zip 00:04:42 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/XsUnDtePTKytTQbE-xS2cw/artifacts/public/build/target.common.tests.zip'}, attempt #1 00:04:42 INFO - Fetch https://queue.taskcluster.net/v1/task/XsUnDtePTKytTQbE-xS2cw/artifacts/public/build/target.common.tests.zip into memory 00:04:43 INFO - Content-Length response header: 54588754 00:04:43 INFO - Bytes received: 54588754 00:04:54 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/XsUnDtePTKytTQbE-xS2cw/artifacts/public/build/target.talos.tests.zip 00:04:54 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/XsUnDtePTKytTQbE-xS2cw/artifacts/public/build/target.talos.tests.zip'}, attempt #1 00:04:54 INFO - Fetch https://queue.taskcluster.net/v1/task/XsUnDtePTKytTQbE-xS2cw/artifacts/public/build/target.talos.tests.zip into memory 00:04:55 INFO - Content-Length response header: 14500356 00:04:55 INFO - Bytes received: 14500356 00:04: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')]} 00:04:55 INFO - trying https://queue.taskcluster.net/v1/task/XsUnDtePTKytTQbE-xS2cw/artifacts/public/build/target.tar.bz2 00:04:55 INFO - Downloading https://queue.taskcluster.net/v1/task/XsUnDtePTKytTQbE-xS2cw/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 00:04:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/XsUnDtePTKytTQbE-xS2cw/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 00:04:57 INFO - Downloaded 61234552 bytes. 00:04:57 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/XsUnDtePTKytTQbE-xS2cw/artifacts/public/build/target.tar.bz2 00:04:57 INFO - mkdir: /builds/slave/test/properties 00:04:57 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 00:04:57 INFO - Writing to file /builds/slave/test/properties/build_url 00:04:57 INFO - Contents: 00:04:57 INFO - build_url:https://queue.taskcluster.net/v1/task/XsUnDtePTKytTQbE-xS2cw/artifacts/public/build/target.tar.bz2 00:04:57 INFO - Running post-action listener: _resource_record_post_action 00:04:57 INFO - Running post-action listener: find_tests_for_verification 00:04:57 INFO - Running post-action listener: set_extra_try_arguments 00:04:57 INFO - [mozharness: 2017-09-14 07:04:57.788682Z] Finished download-and-extract step (success) 00:04:57 INFO - [mozharness: 2017-09-14 07:04:57.788915Z] Running populate-webroot step. 00:04:57 INFO - Running pre-action listener: _resource_record_pre_action 00:04:57 INFO - Running main action method: populate_webroot 00:04:57 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 00:04:57 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 00:04:57 INFO - 'tests': ['tresize', 00:04:57 INFO - 'tcanvasmark']}, 00:04:57 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 00:04:57 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 00:04:57 INFO - 'tests': ['dromaeo_css', 00:04:57 INFO - 'kraken']}, 00:04:57 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 00:04:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:04:57 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 00:04:57 INFO - 'talos_options': ['--disable-stylo'], 00:04:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:04:57 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 00:04:57 INFO - 'tests': ['damp', 'tps']}, 00:04:57 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 00:04:57 INFO - 'talos_options': ['--disable-stylo'], 00:04:57 INFO - 'tests': ['damp', 'tps']}, 00:04:57 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 00:04:57 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 00:04:57 INFO - 'tests': ['dromaeo_dom']}, 00:04:57 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 00:04:57 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 00:04:57 INFO - 'tests': ['basic_compositor_video', 00:04:57 INFO - 'glvideo']}, 00:04:57 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 00:04:57 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 00:04:57 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 00:04:57 INFO - 'talos_options': ['--disable-stylo'], 00:04:57 INFO - 'tests': ['ts_paint_webext', 00:04:57 INFO - 'tp5o_webext']}, 00:04:57 INFO - 'other-e10s': {'tests': ['a11yr', 00:04:57 INFO - 'ts_paint', 00:04:57 INFO - 'tpaint', 00:04:57 INFO - 'sessionrestore', 00:04:57 INFO - 'sessionrestore_many_windows', 00:04:57 INFO - 'sessionrestore_no_auto_restore', 00:04:57 INFO - 'tabpaint']}, 00:04:57 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 00:04:57 INFO - 'tests': ['a11yr', 00:04:57 INFO - 'ts_paint', 00:04:57 INFO - 'tpaint', 00:04:57 INFO - 'sessionrestore', 00:04:57 INFO - 'sessionrestore_many_windows', 00:04:57 INFO - 'sessionrestore_no_auto_restore', 00:04:57 INFO - 'tabpaint']}, 00:04:57 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 00:04:57 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 00:04:57 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 00:04:57 INFO - 'tests': ['bloom_basic_singleton']}, 00:04:57 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 00:04:57 INFO - 'tests': ['bloom_basic']}, 00:04:57 INFO - 'svgr-e10s': {'tests': ['tsvgx', 00:04:57 INFO - 'tsvgr_opacity', 00:04:57 INFO - 'tart', 00:04:57 INFO - 'tscrollx', 00:04:57 INFO - 'tsvg_static']}, 00:04:57 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 00:04:57 INFO - 'tests': ['tsvgx', 00:04:57 INFO - 'tsvgr_opacity', 00:04:57 INFO - 'tart', 00:04:57 INFO - 'tscrollx', 00:04:57 INFO - 'tsvg_static']}, 00:04:57 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 00:04:57 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 00:04:57 INFO - 'talos_options': ['--disable-stylo'], 00:04:57 INFO - 'tests': ['tp5o']}, 00:04:57 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 00:04:57 INFO - 'talos_options': ['--mitmproxy', 00:04:57 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 00:04:57 INFO - '--firstNonBlankPaint'], 00:04:57 INFO - 'tests': ['tp6_google', 00:04:57 INFO - 'tp6_youtube', 00:04:57 INFO - 'tp6_amazon', 00:04:57 INFO - 'tp6_facebook']}, 00:04:57 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 00:04:57 INFO - 'talos_options': ['--disable-stylo', 00:04:57 INFO - '--mitmproxy', 00:04:57 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 00:04:57 INFO - '--firstNonBlankPaint'], 00:04:57 INFO - 'tests': ['tp6_google', 00:04:57 INFO - 'tp6_youtube', 00:04:57 INFO - 'tp6_amazon', 00:04:57 INFO - 'tp6_facebook']}, 00:04:57 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 00:04:57 INFO - 'talos_options': ['--stylo-threads=1', 00:04:57 INFO - '--mitmproxy', 00:04:57 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 00:04:57 INFO - '--firstNonBlankPaint'], 00:04:57 INFO - 'tests': ['tp6_google', 00:04:57 INFO - 'tp6_youtube', 00:04:57 INFO - 'tp6_amazon', 00:04:57 INFO - 'tp6_facebook']}, 00:04:57 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 00:04:57 INFO - 'talos_options': ['--xperf_path', 00:04:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:04:57 INFO - 'tests': ['tp5n']}, 00:04:57 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 00:04:57 INFO - 'talos_options': ['--disable-stylo', 00:04:57 INFO - '--xperf_path', 00:04:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:04:57 INFO - 'tests': ['tp5n']}}} 00:04:57 INFO - Running post-action listener: _resource_record_post_action 00:04:57 INFO - [mozharness: 2017-09-14 07:04:57.813541Z] Finished populate-webroot step (success) 00:04:57 INFO - [mozharness: 2017-09-14 07:04:57.813631Z] Running create-virtualenv step. 00:04:57 INFO - Running pre-action listener: _resource_record_pre_action 00:04:57 INFO - Running main action method: create_virtualenv 00:04:57 INFO - Creating virtualenv /builds/slave/test/build/venv 00:04:57 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 00:04:57 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 00:04:57 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 00:04:57 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 00:04:57 INFO - New python executable in /builds/slave/test/build/venv/bin/python 00:04:58 INFO - Installing distribute.............................................................................................................................................................................................done. 00:04:58 INFO - Installing pip...............done. 00:04:58 INFO - Return code: 0 00:04:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 00:04:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 00:04:58 INFO - Reading from file tmpfile_stdout 00:04:58 INFO - Output received: 00:04:58 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 00:04:58 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 00:04:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:04:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:04:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:04:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:04:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x258f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2758a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28fba60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28ff090>, '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 0x28ffd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28f9f90>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '51fc86400edbde9650d2781a000001d0-1505370572.267818-213713610', '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 00:04:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 00:04:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 00:04:58 INFO - Using env: {'DISPLAY': ':0', 00:04:58 INFO - 'HOME': '/home/cltbld', 00:04:58 INFO - 'LANG': 'en_US.UTF-8', 00:04:58 INFO - 'LANGUAGE': 'en_US:en', 00:04:58 INFO - 'LOGNAME': 'cltbld', 00:04:58 INFO - 'MAIL': '/var/mail/cltbld', 00:04:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:04:58 INFO - 'MOZ_NO_REMOTE': '1', 00:04:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:04:58 INFO - 'NO_EM_RESTART': '1', 00:04:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:04:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:04:58 INFO - 'PWD': '/builds/slave/test', 00:04:58 INFO - 'SHELL': '/bin/bash', 00:04:58 INFO - 'SHLVL': '1', 00:04:58 INFO - 'TERM': 'linux', 00:04:58 INFO - 'TMOUT': '86400', 00:04:58 INFO - 'USER': 'cltbld', 00:04:58 INFO - 'XDG_SESSION_COOKIE': '51fc86400edbde9650d2781a000001d0-1505370572.267818-213713610', 00:04:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:04:58 INFO - '_': '/tools/buildbot/bin/python'} 00:05:00 INFO - Ignoring indexes: http://pypi.python.org/simple/ 00:05:00 INFO - Downloading/unpacking pip>=1.5 00:05:00 INFO - Running setup.py egg_info for package pip 00:05:00 INFO - warning: no files found matching 'pip/cacert.pem' 00:05:00 INFO - warning: no files found matching '*.html' under directory 'docs' 00:05:00 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 00:05:00 INFO - no previously-included directories found matching 'docs/_build/_sources' 00:05:00 INFO - Installing collected packages: pip 00:05:00 INFO - Found existing installation: pip 1.1 00:05:00 INFO - Uninstalling pip: 00:05:00 INFO - Successfully uninstalled pip 00:05:00 INFO - Running setup.py install for pip 00:05:00 INFO - warning: no files found matching 'pip/cacert.pem' 00:05:00 INFO - warning: no files found matching '*.html' under directory 'docs' 00:05:00 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 00:05:00 INFO - no previously-included directories found matching 'docs/_build/_sources' 00:05:00 INFO - Installing pip script to /builds/slave/test/build/venv/bin 00:05:00 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 00:05:00 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 00:05:00 INFO - Successfully installed pip 00:05:00 INFO - Cleaning up... 00:05:00 INFO - Return code: 0 00:05:00 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 00:05:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:05:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:05:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:05:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:05:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x258f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2758a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28fba60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28ff090>, '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 0x28ffd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28f9f90>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '51fc86400edbde9650d2781a000001d0-1505370572.267818-213713610', '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 00:05:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 00:05:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 00:05:00 INFO - Using env: {'DISPLAY': ':0', 00:05:00 INFO - 'HOME': '/home/cltbld', 00:05:00 INFO - 'LANG': 'en_US.UTF-8', 00:05:00 INFO - 'LANGUAGE': 'en_US:en', 00:05:00 INFO - 'LOGNAME': 'cltbld', 00:05:00 INFO - 'MAIL': '/var/mail/cltbld', 00:05:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:05:00 INFO - 'MOZ_NO_REMOTE': '1', 00:05:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:05:00 INFO - 'NO_EM_RESTART': '1', 00:05:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:05:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:05:00 INFO - 'PWD': '/builds/slave/test', 00:05:00 INFO - 'SHELL': '/bin/bash', 00:05:00 INFO - 'SHLVL': '1', 00:05:00 INFO - 'TERM': 'linux', 00:05:00 INFO - 'TMOUT': '86400', 00:05:00 INFO - 'USER': 'cltbld', 00:05:00 INFO - 'XDG_SESSION_COOKIE': '51fc86400edbde9650d2781a000001d0-1505370572.267818-213713610', 00:05:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:05:00 INFO - '_': '/tools/buildbot/bin/python'} 00:05:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:05:00 INFO - Downloading/unpacking psutil>=3.1.1 00:05:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:05:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:05:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:05:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:05:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 00:05:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:05:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:05:01 INFO - Installing collected packages: psutil 00:05:01 INFO - Running setup.py install for psutil 00:05:01 INFO - building 'psutil._psutil_linux' extension 00:05:01 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 00:05: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_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 00:05:01 INFO - building 'psutil._psutil_posix' extension 00:05:01 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 00:05: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 00:05:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:05:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:05:01 INFO - Successfully installed psutil 00:05:01 INFO - Cleaning up... 00:05:02 INFO - Return code: 0 00:05:02 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 00:05:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:05:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:05:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:05:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:05:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x258f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2758a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28fba60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28ff090>, '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 0x28ffd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28f9f90>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '51fc86400edbde9650d2781a000001d0-1505370572.267818-213713610', '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 00:05:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 00:05:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 00:05:02 INFO - Using env: {'DISPLAY': ':0', 00:05:02 INFO - 'HOME': '/home/cltbld', 00:05:02 INFO - 'LANG': 'en_US.UTF-8', 00:05:02 INFO - 'LANGUAGE': 'en_US:en', 00:05:02 INFO - 'LOGNAME': 'cltbld', 00:05:02 INFO - 'MAIL': '/var/mail/cltbld', 00:05:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:05:02 INFO - 'MOZ_NO_REMOTE': '1', 00:05:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:05:02 INFO - 'NO_EM_RESTART': '1', 00:05:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:05:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:05:02 INFO - 'PWD': '/builds/slave/test', 00:05:02 INFO - 'SHELL': '/bin/bash', 00:05:02 INFO - 'SHLVL': '1', 00:05:02 INFO - 'TERM': 'linux', 00:05:02 INFO - 'TMOUT': '86400', 00:05:02 INFO - 'USER': 'cltbld', 00:05:02 INFO - 'XDG_SESSION_COOKIE': '51fc86400edbde9650d2781a000001d0-1505370572.267818-213713610', 00:05:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:05:02 INFO - '_': '/tools/buildbot/bin/python'} 00:05:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:05:02 INFO - Downloading/unpacking mozsystemmonitor==0.3 00:05:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:05:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:05:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:05:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:05:03 INFO - Downloading mozsystemmonitor-0.3.tar.gz 00:05:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 00:05:03 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 00:05:03 INFO - Installing collected packages: mozsystemmonitor 00:05:03 INFO - Running setup.py install for mozsystemmonitor 00:05:04 INFO - Successfully installed mozsystemmonitor 00:05:04 INFO - Cleaning up... 00:05:04 INFO - Return code: 0 00:05:04 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 00:05:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:05:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:05:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:05:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:05:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x258f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2758a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28fba60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28ff090>, '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 0x28ffd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28f9f90>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '51fc86400edbde9650d2781a000001d0-1505370572.267818-213713610', '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 00:05:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 00:05:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 00:05:04 INFO - Using env: {'DISPLAY': ':0', 00:05:04 INFO - 'HOME': '/home/cltbld', 00:05:04 INFO - 'LANG': 'en_US.UTF-8', 00:05:04 INFO - 'LANGUAGE': 'en_US:en', 00:05:04 INFO - 'LOGNAME': 'cltbld', 00:05:04 INFO - 'MAIL': '/var/mail/cltbld', 00:05:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:05:04 INFO - 'MOZ_NO_REMOTE': '1', 00:05:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:05:04 INFO - 'NO_EM_RESTART': '1', 00:05:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:05:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:05:04 INFO - 'PWD': '/builds/slave/test', 00:05:04 INFO - 'SHELL': '/bin/bash', 00:05:04 INFO - 'SHLVL': '1', 00:05:04 INFO - 'TERM': 'linux', 00:05:04 INFO - 'TMOUT': '86400', 00:05:04 INFO - 'USER': 'cltbld', 00:05:04 INFO - 'XDG_SESSION_COOKIE': '51fc86400edbde9650d2781a000001d0-1505370572.267818-213713610', 00:05:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:05:04 INFO - '_': '/tools/buildbot/bin/python'} 00:05:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:05:04 INFO - Downloading/unpacking jsonschema==2.5.1 00:05: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 00:05: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 00:05: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 00:05: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 00:05:05 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 00:05:06 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 00:05: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 00:05: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 00:05: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 00:05: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 00:05:06 INFO - Downloading functools32-3.2.3-2.tar.gz 00:05:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 00:05:06 INFO - warning: no files found matching '*.txt' 00:05:06 INFO - no previously-included directories found matching 'build' 00:05:06 INFO - no previously-included directories found matching 'dist' 00:05:06 INFO - no previously-included directories found matching '.git*' 00:05:06 INFO - Installing collected packages: jsonschema, functools32 00:05:06 INFO - Running setup.py install for functools32 00:05:06 INFO - warning: no files found matching '*.txt' 00:05:06 INFO - no previously-included directories found matching 'build' 00:05:06 INFO - no previously-included directories found matching 'dist' 00:05:06 INFO - no previously-included directories found matching '.git*' 00:05:06 INFO - Successfully installed jsonschema functools32 00:05:06 INFO - Cleaning up... 00:05:06 INFO - Return code: 0 00:05:06 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 00:05:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:05:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:05:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:05:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:05:06 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 0x258f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2758a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28fba60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28ff090>, '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 0x28ffd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28f9f90>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '51fc86400edbde9650d2781a000001d0-1505370572.267818-213713610', '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 00:05:06 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 00:05:06 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 00:05:06 INFO - Using env: {'DISPLAY': ':0', 00:05:06 INFO - 'HOME': '/home/cltbld', 00:05:06 INFO - 'LANG': 'en_US.UTF-8', 00:05:06 INFO - 'LANGUAGE': 'en_US:en', 00:05:06 INFO - 'LOGNAME': 'cltbld', 00:05:06 INFO - 'MAIL': '/var/mail/cltbld', 00:05:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:05:06 INFO - 'MOZ_NO_REMOTE': '1', 00:05:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:05:06 INFO - 'NO_EM_RESTART': '1', 00:05:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:05:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:05:06 INFO - 'PWD': '/builds/slave/test', 00:05:06 INFO - 'SHELL': '/bin/bash', 00:05:06 INFO - 'SHLVL': '1', 00:05:06 INFO - 'TERM': 'linux', 00:05:06 INFO - 'TMOUT': '86400', 00:05:06 INFO - 'USER': 'cltbld', 00:05:06 INFO - 'XDG_SESSION_COOKIE': '51fc86400edbde9650d2781a000001d0-1505370572.267818-213713610', 00:05:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:05:06 INFO - '_': '/tools/buildbot/bin/python'} 00:05:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:05:06 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 00:05:06 INFO - Cleaning up... 00:05:06 INFO - Return code: 0 00:05:06 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 00:05:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:05:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:05:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:05:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:05:06 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 0x258f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2758a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28fba60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28ff090>, '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 0x28ffd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28f9f90>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '51fc86400edbde9650d2781a000001d0-1505370572.267818-213713610', '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 00:05:06 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 00:05:06 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 00:05:06 INFO - Using env: {'DISPLAY': ':0', 00:05:06 INFO - 'HOME': '/home/cltbld', 00:05:06 INFO - 'LANG': 'en_US.UTF-8', 00:05:06 INFO - 'LANGUAGE': 'en_US:en', 00:05:06 INFO - 'LOGNAME': 'cltbld', 00:05:06 INFO - 'MAIL': '/var/mail/cltbld', 00:05:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:05:06 INFO - 'MOZ_NO_REMOTE': '1', 00:05:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:05:06 INFO - 'NO_EM_RESTART': '1', 00:05:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:05:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:05:06 INFO - 'PWD': '/builds/slave/test', 00:05:06 INFO - 'SHELL': '/bin/bash', 00:05:06 INFO - 'SHLVL': '1', 00:05:06 INFO - 'TERM': 'linux', 00:05:06 INFO - 'TMOUT': '86400', 00:05:06 INFO - 'USER': 'cltbld', 00:05:06 INFO - 'XDG_SESSION_COOKIE': '51fc86400edbde9650d2781a000001d0-1505370572.267818-213713610', 00:05:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:05:06 INFO - '_': '/tools/buildbot/bin/python'} 00:05:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:05:06 INFO - Downloading/unpacking blobuploader==1.2.4 00:05: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 00:05: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 00:05: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 00:05: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 00:05:07 INFO - Downloading blobuploader-1.2.4.tar.gz 00:05:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 00:05:08 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 00:05:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:05:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:05:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:05:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:05:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 00:05:08 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 00:05:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:05:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:05:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:05:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:05:08 INFO - Downloading docopt-0.6.1.tar.gz 00:05:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 00:05:08 INFO - Installing collected packages: blobuploader, requests, docopt 00:05:08 INFO - Running setup.py install for blobuploader 00:05:08 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 00:05:08 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 00:05:08 INFO - Running setup.py install for requests 00:05:09 INFO - Running setup.py install for docopt 00:05:09 INFO - Successfully installed blobuploader requests docopt 00:05:09 INFO - Cleaning up... 00:05:09 INFO - Return code: 0 00:05:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:05:09 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')]} 00:05:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:05:09 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')]} 00:05:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:05:09 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 0x258f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2758a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28fba60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28ff090>, '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 0x28ffd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28f9f90>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '51fc86400edbde9650d2781a000001d0-1505370572.267818-213713610', '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 00:05:09 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 00:05:09 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 00:05:09 INFO - Using env: {'DISPLAY': ':0', 00:05:09 INFO - 'HOME': '/home/cltbld', 00:05:09 INFO - 'LANG': 'en_US.UTF-8', 00:05:09 INFO - 'LANGUAGE': 'en_US:en', 00:05:09 INFO - 'LOGNAME': 'cltbld', 00:05:09 INFO - 'MAIL': '/var/mail/cltbld', 00:05:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:05:09 INFO - 'MOZ_NO_REMOTE': '1', 00:05:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:05:09 INFO - 'NO_EM_RESTART': '1', 00:05:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:05:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:05:09 INFO - 'PWD': '/builds/slave/test', 00:05:09 INFO - 'SHELL': '/bin/bash', 00:05:09 INFO - 'SHLVL': '1', 00:05:09 INFO - 'TERM': 'linux', 00:05:09 INFO - 'TMOUT': '86400', 00:05:09 INFO - 'USER': 'cltbld', 00:05:09 INFO - 'XDG_SESSION_COOKIE': '51fc86400edbde9650d2781a000001d0-1505370572.267818-213713610', 00:05:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:05:09 INFO - '_': '/tools/buildbot/bin/python'} 00:05:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:05:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 00:05:09 INFO - Running setup.py (path:/tmp/pip-Gk3R2Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 00:05:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 00:05:09 INFO - Running setup.py (path:/tmp/pip-c2VI0T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 00:05:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 00:05:09 INFO - Running setup.py (path:/tmp/pip-zbQ9wz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 00:05:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 00:05:09 INFO - Running setup.py (path:/tmp/pip-3qFxGv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 00:05:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 00:05:09 INFO - Running setup.py (path:/tmp/pip-SiPPWW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 00:05:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 00:05:09 INFO - Running setup.py (path:/tmp/pip-QEPxcH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 00:05:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 00:05:09 INFO - Running setup.py (path:/tmp/pip-aOEZRn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 00:05:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 00:05:09 INFO - Running setup.py (path:/tmp/pip-wrzFwC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 00:05:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 00:05:09 INFO - Running setup.py (path:/tmp/pip-SQqm33-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 00:05:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 00:05:09 INFO - Running setup.py (path:/tmp/pip-to5qux-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 00:05:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 00:05:10 INFO - Running setup.py (path:/tmp/pip-C0yqFA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 00:05:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 00:05:10 INFO - Running setup.py (path:/tmp/pip-n4GkwZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 00:05:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 00:05:10 INFO - Running setup.py (path:/tmp/pip-8nzQbt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 00:05:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 00:05:10 INFO - Running setup.py (path:/tmp/pip-Keb2yw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 00:05:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 00:05:10 INFO - Running setup.py (path:/tmp/pip-dgnEXq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 00:05:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 00:05:10 INFO - Running setup.py (path:/tmp/pip-4BjxYn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 00:05:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 00:05:10 INFO - Running setup.py (path:/tmp/pip-5JpRuv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 00:05:10 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 00:05:10 INFO - Running setup.py install for manifestparser 00:05:10 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 00:05:10 INFO - Running setup.py install for mozcrash 00:05:10 INFO - Running setup.py install for mozdebug 00:05:10 INFO - Running setup.py install for mozdevice 00:05:10 INFO - Installing dm script to /builds/slave/test/build/venv/bin 00:05:10 INFO - Running setup.py install for mozfile 00:05:11 INFO - Running setup.py install for mozhttpd 00:05:11 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 00:05:11 INFO - Running setup.py install for mozinfo 00:05:11 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 00:05:11 INFO - Running setup.py install for mozInstall 00:05:11 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 00:05:11 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 00:05:11 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 00:05:11 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 00:05:11 INFO - Running setup.py install for mozleak 00:05:11 INFO - Running setup.py install for mozlog 00:05:11 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 00:05:11 INFO - Running setup.py install for moznetwork 00:05:11 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 00:05:11 INFO - Running setup.py install for mozprocess 00:05:11 INFO - Running setup.py install for mozprofile 00:05:11 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 00:05:11 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 00:05:11 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 00:05:11 INFO - Running setup.py install for mozrunner 00:05:11 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 00:05:12 INFO - Running setup.py install for mozscreenshot 00:05:12 INFO - Running setup.py install for moztest 00:05:12 INFO - Running setup.py install for mozversion 00:05:12 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 00:05:12 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 00:05:12 INFO - Cleaning up... 00:05:12 INFO - Return code: 0 00:05:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:05:12 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')]} 00:05:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:05:12 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')]} 00:05:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:05:12 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 0x258f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2758a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28fba60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28ff090>, '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 0x28ffd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28f9f90>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '51fc86400edbde9650d2781a000001d0-1505370572.267818-213713610', '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 00:05:12 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 00:05:12 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 00:05:12 INFO - Using env: {'DISPLAY': ':0', 00:05:12 INFO - 'HOME': '/home/cltbld', 00:05:12 INFO - 'LANG': 'en_US.UTF-8', 00:05:12 INFO - 'LANGUAGE': 'en_US:en', 00:05:12 INFO - 'LOGNAME': 'cltbld', 00:05:12 INFO - 'MAIL': '/var/mail/cltbld', 00:05:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:05:12 INFO - 'MOZ_NO_REMOTE': '1', 00:05:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:05:12 INFO - 'NO_EM_RESTART': '1', 00:05:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:05:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:05:12 INFO - 'PWD': '/builds/slave/test', 00:05:12 INFO - 'SHELL': '/bin/bash', 00:05:12 INFO - 'SHLVL': '1', 00:05:12 INFO - 'TERM': 'linux', 00:05:12 INFO - 'TMOUT': '86400', 00:05:12 INFO - 'USER': 'cltbld', 00:05:12 INFO - 'XDG_SESSION_COOKIE': '51fc86400edbde9650d2781a000001d0-1505370572.267818-213713610', 00:05:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:05:12 INFO - '_': '/tools/buildbot/bin/python'} 00:05:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:05:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 00:05:12 INFO - Running setup.py (path:/tmp/pip-RiwB0Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 00:05:12 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)) 00:05:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 00:05:12 INFO - Running setup.py (path:/tmp/pip-Ch3Bpw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 00:05:12 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)) 00:05:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 00:05:12 INFO - Running setup.py (path:/tmp/pip-wzOVOA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 00:05:12 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)) 00:05:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 00:05:12 INFO - Running setup.py (path:/tmp/pip-GHj9p4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 00:05:12 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)) 00:05:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 00:05:12 INFO - Running setup.py (path:/tmp/pip-4eqaQ1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 00:05:12 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)) 00:05:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 00:05:12 INFO - Running setup.py (path:/tmp/pip-p4PSoV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 00:05:12 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)) 00:05:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 00:05:12 INFO - Running setup.py (path:/tmp/pip-fJe8W4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 00:05:13 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)) 00:05:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 00:05:13 INFO - Running setup.py (path:/tmp/pip-w6CXRf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 00:05:13 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)) 00:05:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 00:05:13 INFO - Running setup.py (path:/tmp/pip-WSc2cd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 00:05:13 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)) 00:05:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 00:05:13 INFO - Running setup.py (path:/tmp/pip-oEIldc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 00:05:13 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)) 00:05:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 00:05:13 INFO - Running setup.py (path:/tmp/pip-1SyYFJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 00:05:13 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)) 00:05:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 00:05:13 INFO - Running setup.py (path:/tmp/pip-lZ7v5f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 00:05:13 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)) 00:05:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 00:05:13 INFO - Running setup.py (path:/tmp/pip-0J_P2F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 00:05:13 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)) 00:05:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 00:05:13 INFO - Running setup.py (path:/tmp/pip-vq8We2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 00:05:13 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)) 00:05:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 00:05:13 INFO - Running setup.py (path:/tmp/pip-YhRPsF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 00:05:13 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)) 00:05:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 00:05:13 INFO - Running setup.py (path:/tmp/pip-JyLlfb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 00:05:13 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)) 00:05:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 00:05:13 INFO - Running setup.py (path:/tmp/pip-P0bVaR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 00:05:13 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)) 00:05:13 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)) 00:05:13 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)) 00:05:13 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)) 00:05:13 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)) 00:05:13 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)) 00:05:13 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)) 00:05:13 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 00:05:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:05:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:05:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:05:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:05:14 INFO - Downloading blessings-1.6.tar.gz 00:05:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 00:05:14 INFO - Installing collected packages: blessings 00:05:14 INFO - Running setup.py install for blessings 00:05:15 INFO - Successfully installed blessings 00:05:15 INFO - Cleaning up... 00:05:15 INFO - Return code: 0 00:05:15 INFO - Done creating virtualenv /builds/slave/test/build/venv. 00:05:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 00:05:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 00:05:15 INFO - Reading from file tmpfile_stdout 00:05:15 INFO - Current package versions: 00:05:15 INFO - argparse == 1.2.1 00:05:15 INFO - blessings == 1.6 00:05:15 INFO - blobuploader == 1.2.4 00:05:15 INFO - docopt == 0.6.1 00:05:15 INFO - functools32 == 3.2.3-2 00:05:15 INFO - jsonschema == 2.5.1 00:05:15 INFO - manifestparser == 1.1 00:05:15 INFO - mozInstall == 1.13 00:05:15 INFO - mozcrash == 1.0 00:05:15 INFO - mozdebug == 0.1 00:05:15 INFO - mozdevice == 0.51 00:05:15 INFO - mozfile == 1.2 00:05:15 INFO - mozhttpd == 0.7 00:05:15 INFO - mozinfo == 0.10 00:05:15 INFO - mozleak == 0.1 00:05:15 INFO - mozlog == 3.5 00:05:15 INFO - moznetwork == 0.27 00:05:15 INFO - mozprocess == 0.25 00:05:15 INFO - mozprofile == 0.28 00:05:15 INFO - mozrunner == 6.13 00:05:15 INFO - mozscreenshot == 0.1 00:05:15 INFO - mozsystemmonitor == 0.3 00:05:15 INFO - moztest == 0.8 00:05:15 INFO - mozversion == 1.4 00:05:15 INFO - psutil == 3.1.1 00:05:15 INFO - requests == 1.2.3 00:05:15 INFO - wsgiref == 0.1.2 00:05:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:05:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:05:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:05:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:05:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:05:15 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 0x258f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2758a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28fba60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28ff090>, '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 0x28ffd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28f9f90>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '51fc86400edbde9650d2781a000001d0-1505370572.267818-213713610', '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 00:05:15 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 00:05:15 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 00:05:15 INFO - Using env: {'DISPLAY': ':0', 00:05:15 INFO - 'HOME': '/home/cltbld', 00:05:15 INFO - 'LANG': 'en_US.UTF-8', 00:05:15 INFO - 'LANGUAGE': 'en_US:en', 00:05:15 INFO - 'LOGNAME': 'cltbld', 00:05:15 INFO - 'MAIL': '/var/mail/cltbld', 00:05:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:05:15 INFO - 'MOZ_NO_REMOTE': '1', 00:05:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:05:15 INFO - 'NO_EM_RESTART': '1', 00:05:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:05:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:05:15 INFO - 'PWD': '/builds/slave/test', 00:05:15 INFO - 'SHELL': '/bin/bash', 00:05:15 INFO - 'SHLVL': '1', 00:05:15 INFO - 'TERM': 'linux', 00:05:15 INFO - 'TMOUT': '86400', 00:05:15 INFO - 'USER': 'cltbld', 00:05:15 INFO - 'XDG_SESSION_COOKIE': '51fc86400edbde9650d2781a000001d0-1505370572.267818-213713610', 00:05:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:05:15 INFO - '_': '/tools/buildbot/bin/python'} 00:05:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:05:15 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)) 00:05:15 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)) 00:05:15 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)) 00:05:15 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)) 00:05:15 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)) 00:05:15 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)) 00:05:15 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)) 00:05:15 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)) 00:05:15 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)) 00:05:15 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 00:05:15 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 00:05:15 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 00:05:15 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 00:05:15 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 00:05:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 00:05:16 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)) 00:05:16 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)) 00:05:16 INFO - Installing collected packages: simplejson 00:05:16 INFO - Running setup.py install for simplejson 00:05:16 INFO - building 'simplejson._speedups' extension 00:05:16 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 00:05:17 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 00:05:17 INFO - Successfully installed simplejson 00:05:17 INFO - Cleaning up... 00:05:17 INFO - Return code: 0 00:05:17 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 00:05:17 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')]} 00:05:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:05:17 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')]} 00:05:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:05:17 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 0x258f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2758a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28fba60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28ff090>, '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 0x28ffd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28f9f90>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '51fc86400edbde9650d2781a000001d0-1505370572.267818-213713610', '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 00:05:17 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 00:05:17 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 00:05:17 INFO - Using env: {'DISPLAY': ':0', 00:05:17 INFO - 'HOME': '/home/cltbld', 00:05:17 INFO - 'LANG': 'en_US.UTF-8', 00:05:17 INFO - 'LANGUAGE': 'en_US:en', 00:05:17 INFO - 'LOGNAME': 'cltbld', 00:05:17 INFO - 'MAIL': '/var/mail/cltbld', 00:05:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:05:17 INFO - 'MOZ_NO_REMOTE': '1', 00:05:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:05:17 INFO - 'NO_EM_RESTART': '1', 00:05:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:05:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:05:17 INFO - 'PWD': '/builds/slave/test', 00:05:17 INFO - 'SHELL': '/bin/bash', 00:05:17 INFO - 'SHLVL': '1', 00:05:17 INFO - 'TERM': 'linux', 00:05:17 INFO - 'TMOUT': '86400', 00:05:17 INFO - 'USER': 'cltbld', 00:05:17 INFO - 'XDG_SESSION_COOKIE': '51fc86400edbde9650d2781a000001d0-1505370572.267818-213713610', 00:05:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:05:17 INFO - '_': '/tools/buildbot/bin/python'} 00:05:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:05:17 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 00:05:17 INFO - Cleaning up... 00:05:17 INFO - Return code: 0 00:05:17 INFO - Running post-action listener: _resource_record_post_action 00:05:17 INFO - Running post-action listener: _start_resource_monitoring 00:05:18 INFO - Starting resource monitoring. 00:05:18 INFO - [mozharness: 2017-09-14 07:05:18.027534Z] Finished create-virtualenv step (success) 00:05:18 INFO - [mozharness: 2017-09-14 07:05:18.027993Z] Running install step. 00:05:18 INFO - Running pre-action listener: _resource_record_pre_action 00:05:18 INFO - Running main action method: install 00:05:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 00:05:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 00:05:18 INFO - Reading from file tmpfile_stdout 00:05:18 INFO - Detecting whether we're running mozinstall >=1.0... 00:05:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 00:05:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 00:05:18 INFO - Reading from file tmpfile_stdout 00:05:18 INFO - Output received: 00:05:18 INFO - Usage: mozinstall [options] installer 00:05:18 INFO - Options: 00:05:18 INFO - -h, --help show this help message and exit 00:05:18 INFO - -d DEST, --destination=DEST 00:05:18 INFO - Directory to install application into. [default: 00:05:18 INFO - "/builds/slave/test"] 00:05:18 INFO - --app=APP Application being installed. [default: firefox] 00:05:18 INFO - mkdir: /builds/slave/test/build/application 00:05:18 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'] 00:05:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 00:05:36 INFO - Reading from file tmpfile_stdout 00:05:36 INFO - Output received: 00:05:36 INFO - /builds/slave/test/build/application/firefox/firefox 00:05:36 INFO - Running post-action listener: _resource_record_post_action 00:05:36 INFO - [mozharness: 2017-09-14 07:05:36.090644Z] Finished install step (success) 00:05:36 INFO - [mozharness: 2017-09-14 07:05:36.090770Z] Running setup-mitmproxy step. 00:05:36 INFO - Running pre-action listener: _resource_record_pre_action 00:05:36 INFO - Running main action method: setup_mitmproxy 00:05:36 INFO - Skipping: mitmproxy is not required 00:05:36 INFO - Running post-action listener: _resource_record_post_action 00:05:36 INFO - [mozharness: 2017-09-14 07:05:36.091697Z] Finished setup-mitmproxy step (success) 00:05:36 INFO - [mozharness: 2017-09-14 07:05:36.091918Z] Running run-tests step. 00:05:36 INFO - Running pre-action listener: _resource_record_pre_action 00:05:36 INFO - Running pre-action listener: _set_gcov_prefix 00:05:36 INFO - Running main action method: run_tests 00:05:36 WARNING - Try message not found. 00:05:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 00:05:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 00:05:36 INFO - Python 2.7.3 00:05:36 INFO - Return code: 0 00:05:36 INFO - grabbing minidump binary from tooltool 00:05:36 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')]} 00:05:36 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 0x28ff090>, '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 0x28ffd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28f9f90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 00:05:36 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 00:05:36 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 00:05:36 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 00:05:36 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 00:05:36 INFO - Return code: 0 00:05:36 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 00:05:36 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 00:05:36 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 00:05:36 INFO - ENV: RUST_BACKTRACE is now full 00:05:36 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 00:05:36 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 00:05:36 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/XsUnDtePTKytTQbE-xS2cw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-082', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 00:05:36 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/XsUnDtePTKytTQbE-xS2cw/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-082 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 00:05:36 INFO - Using env: {'DISPLAY': ':0', 00:05:36 INFO - 'HOME': '/home/cltbld', 00:05:36 INFO - 'LANG': 'en_US.UTF-8', 00:05:36 INFO - 'LANGUAGE': 'en_US:en', 00:05:36 INFO - 'LOGNAME': 'cltbld', 00:05:36 INFO - 'MAIL': '/var/mail/cltbld', 00:05:36 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 00:05:36 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 00:05:36 INFO - 'MOZ_ACCELERATED': '1', 00:05:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:05:36 INFO - 'MOZ_NO_REMOTE': '1', 00:05:36 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 00:05:36 INFO - 'MOZ_WEBRENDER': '1', 00:05:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:05:36 INFO - 'NO_EM_RESTART': '1', 00:05:36 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:05:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:05:36 INFO - 'PWD': '/builds/slave/test', 00:05:36 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 00:05:36 INFO - 'RUST_BACKTRACE': 'full', 00:05:36 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 00:05:36 INFO - 'SHELL': '/bin/bash', 00:05:36 INFO - 'SHLVL': '1', 00:05:36 INFO - 'TERM': 'linux', 00:05:36 INFO - 'TMOUT': '86400', 00:05:36 INFO - 'USER': 'cltbld', 00:05:36 INFO - 'XDG_SESSION_COOKIE': '51fc86400edbde9650d2781a000001d0-1505370572.267818-213713610', 00:05:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:05:36 INFO - '_': '/tools/buildbot/bin/python'} 00:05:36 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/XsUnDtePTKytTQbE-xS2cw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-082', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 00:05:36 INFO - mozversion application_buildid: 20170914061749 00:05:36 INFO - mozversion application_changeset: 9517eea4a1a5955618fc79d039f9f0282b7185ca 00:05:36 INFO - mozversion application_display_name: Nightly 00:05:36 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 00:05:36 INFO - mozversion application_name: Firefox 00:05:36 INFO - mozversion application_remotingname: firefox 00:05:36 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 00:05:36 INFO - mozversion application_vendor: Mozilla 00:05:36 INFO - mozversion application_version: 57.0a1 00:05:36 INFO - mozversion platform_buildid: 20170914061749 00:05:36 INFO - mozversion platform_changeset: 9517eea4a1a5955618fc79d039f9f0282b7185ca 00:05:36 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 00:05:36 INFO - mozversion platform_version: 57.0a1 00:05:36 INFO - using testdate: 1505372736 00:05:36 INFO - actual date: 1505372736 00:05:36 INFO - starting webserver on 'localhost:46372' 00:05:36 INFO - SUITE-START | Running 2 tests 00:05:36 INFO - TEST-START | dromaeo_css 00:05:36 INFO - Initialising browser for dromaeo_css test... 00:05:36 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:46372/getInfo.html -profile /tmp/tmpbtjhHV/profile 00:05:36 INFO - TEST-INFO | started process 3021 (/builds/slave/test/build/application/firefox/firefox http://localhost:46372/getInfo.html) 00:05:44 INFO - TEST-INFO | 3021: exit 0 00:05:44 INFO - Browser initialized. 00:05:44 INFO - Running cycle 1/1 for dromaeo_css test... 00:05:44 INFO - Using env: {'DISPLAY': ':0', 00:05:44 INFO - 'HOME': '/home/cltbld', 00:05:44 INFO - 'JSGC_DISABLE_POISONING': '1', 00:05:44 INFO - 'LANG': 'en_US.UTF-8', 00:05:44 INFO - 'LANGUAGE': 'en_US:en', 00:05:44 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 00:05:44 INFO - 'LOGNAME': 'cltbld', 00:05:44 INFO - 'MAIL': '/var/mail/cltbld', 00:05:44 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 00:05:44 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 00:05:44 INFO - 'MOZ_ACCELERATED': '1', 00:05:44 INFO - 'MOZ_CRASHREPORTER': '1', 00:05:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:05:44 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 00:05:44 INFO - 'MOZ_NO_REMOTE': '1', 00:05:44 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 00:05:44 INFO - 'MOZ_WEBRENDER': '1', 00:05:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:05:44 INFO - 'NO_EM_RESTART': '1', 00:05:44 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:05:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:05:44 INFO - 'PWD': '/builds/slave/test', 00:05:44 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 00:05:44 INFO - 'RUST_BACKTRACE': 'full', 00:05:44 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 00:05:44 INFO - 'SHELL': '/bin/bash', 00:05:44 INFO - 'SHLVL': '1', 00:05:44 INFO - 'TERM': 'linux', 00:05:44 INFO - 'TMOUT': '86400', 00:05:44 INFO - 'USER': 'cltbld', 00:05:44 INFO - 'XDG_SESSION_COOKIE': '51fc86400edbde9650d2781a000001d0-1505370572.267818-213713610', 00:05:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:05:44 INFO - '_': '/tools/buildbot/bin/python'} 00:05:44 INFO - TEST-INFO | started process 3316 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbtjhHV/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 00:05:45 INFO - PID 3316 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 00:05:45 INFO - PID 3316 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 00:05:45 INFO - PID 3316 | 00:05:45 INFO - PID 3316 | (/builds/slave/test/build/application/firefox/firefox:3375): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 00:05:45 INFO - PID 3316 | 00:05:56 INFO - PID 3316 | RSS: Main: 213364736 00:05:56 INFO - PID 3316 | 00:08:54 INFO - PID 3316 | Cycle 1(1): loaded http://localhost:46372/tests/dromaeo/cssquery-dojo.html (next: http://localhost:46372/tests/dromaeo/cssquery-ext.html) 00:08:55 INFO - PID 3316 | RSS: Main: 220549120 00:08:55 INFO - PID 3316 | 00:11:57 INFO - PID 3316 | Cycle 1(1): loaded http://localhost:46372/tests/dromaeo/cssquery-ext.html (next: http://localhost:46372/tests/dromaeo/cssquery-jquery.html) 00:11:58 INFO - PID 3316 | RSS: Main: 223272960 00:11:58 INFO - PID 3316 | 00:15:00 INFO - PID 3316 | Cycle 1(1): loaded http://localhost:46372/tests/dromaeo/cssquery-jquery.html (next: http://localhost:46372/tests/dromaeo/cssquery-mootools.html) 00:15:01 INFO - PID 3316 | RSS: Main: 220897280 00:15:01 INFO - PID 3316 | 00:18:03 INFO - PID 3316 | Cycle 1(1): loaded http://localhost:46372/tests/dromaeo/cssquery-mootools.html (next: http://localhost:46372/tests/dromaeo/cssquery-prototype.html) 00:18:03 INFO - PID 3316 | RSS: Main: 224841728 00:18:03 INFO - PID 3316 | 00:21:07 INFO - PID 3316 | Cycle 1(1): loaded http://localhost:46372/tests/dromaeo/cssquery-prototype.html (next: http://localhost:46372/tests/dromaeo/cssquery-yui.html) 00:21:07 INFO - PID 3316 | RSS: Main: 226918400 00:21:07 INFO - PID 3316 | 00:24:09 INFO - PID 3316 | Cycle 1(1): loaded http://localhost:46372/tests/dromaeo/cssquery-yui.html (next: http://localhost:46372/tests/dromaeo/cssquery-dojo.html) 00:24:10 INFO - PID 3316 | RSS: Main: 226902016 00:24:10 INFO - PID 3316 | 00:24:10 INFO - PID 3316 | __start_tp_report 00:24:10 INFO - PID 3316 | _x_x_mozilla_page_load 00:24:10 INFO - PID 3316 | _x_x_mozilla_page_load_details 00:24:10 INFO - PID 3316 | |i|pagename|runs| 00:24:10 INFO - PID 3316 | |0;dojo.html;3099.6900309969;3120.2043478912874;3120.9375812483763;3127.968720312797;3132.3578666373396;6017.127516510103;6135.233095863017;6142.877142457148;6221.066839974006;6266.62400255985;6105.267367915856;6164.506839452833;6196.349383314755;6210.2547694276755;6238.157848690425;5721.713914304279;5726.45598668128;5747.3677895431465;5759.1937128802;5794.0729483282685;5685.204071430003;5763.769449222026;5767.394423585526;5792.855178620526;5803.448672376117;5691.174779656947;5723.656580605177;5725.770969161229;5751.712414379285;5793.217915581385;5742.196092547047;5748.482636562709;5764.048931926227;5818.883622327529;5841.85395365115;5251.474852514756;5513.669179849222;5591.3569939456665;5607;5623.156526521055;6082.756689732405;6124.173236613089;6243.87512249757;6254.312025677172;6255.468285195764;6522.804315870531;6554.934450655528;6625.86748265032;6632.8673426531195;6718;6677.465802735769;6694.732210711566;6719.899201511981;6721.0926524919;6735.12443382362;6157.014877619604;6171.691415429211;6228.22147231596;6249.375062493759;6257.937420625781;6806.591604503746;6862.382385585322;6867.107276054081;6889.448844092561;6914.412274956685;6261.78083767066;6390.552661313756;6435.871282574322;6580.506462015368;6623.172103487064;6620.337966203341;6669.966650166718;6687.465002799764;6723.193216813916;6753.8649227015185;6597.274299827015;6640.8671826563195;6698.263191048981;6719.361660642329;6734.3602357775935;6661.1007513985;6661.600303981777;6731;6744.123263975652;6749.797506074826;5006.699598024057;5080.237964305384;5080.542751152414;5086.872828179326;5150.124478838607;4472.530384309665;4501.594856462934;4508.233600287959;4526;4594.264917613166;5616.69108199053;5667.234923285304;5702.657840529581;5713.114467257582;5728.283964504437;6616.669166541654;6619.371159739817;6627.271000189975;6637.1703537057865;6651.16860392451;5674.26234589509;5686.630369026;5697.487226149667;5707.514861236758;5718.914216286759;5475.151351540518;5592.217089607459;5606;5617.297837770278;5632.633878797865;6349.428551430301;6413.615183089029;6476.255230648441;6503.2521260054755;6532.150820393318;6650.235222949423;6653.434458071119;6725.327467253235;6727.596344219264;6777.796666100025;6280.497560195265;6406;6420.711068001858;6440.8389790255615;6455.419012288917;6550.279469258473;6570.47436205112;6575.572587781779;6588.242352129375;6603.273639899703;6608.9095299277005;6747.932520674927;6757.3242675732035;6766.7969960901255;6767.695453704693;6443.323451037573;6447.6453795041725;6517.576357536745;6526.608403495806;6530.412262896362;6313.810585682253;6333.714982825692;6354.364563543609;6419.197600299963;6471;6343.207099112611;6395.93604063972;6413.935860641333;6423.743050277936;6427.325130861379;6464.353564643498;6500.902486462802;6505.089287499848;6590.176227971504;6601.735930562723;6136.815895523141;6250.4374606285655;6265.091561723616;6275.623462592259;6339.429451349401 00:24:10 INFO - PID 3316 | |1;ext.html;795.6658203554507;820.192110770891;822.0382152881128;822.5928165558049;825.7605294464605;38371;41522.37716434256;41852.79073604635;41874.16251674968;42152.36771448431;38575.421368679425;38645.227095458074;38959.22081558367;38984.61015389845;39051;6966.4078553323025;7033.156021277454;7073.328033836803;7083.433325333961;7560.054993125859;7657.502262352929;7776.961115194416;7846.72536461224;7847.411444141712;7847.6860925562905;7829.256220659028;7842.215778422169;7842.647080881374;7852.921470785276;7917.683292668286;7739.6517156727805;7782.610869456505;7824.295813376766;7832.686692532292;7842.8431431371055;7733.845323093563;7772.300492955605;7775.922240777633;7796.72711455102;7797.220277972157;39086;39268.80365598154;39355.60644393548;39395.60604393948;39417.211655766725;3542.4863394807867;3574.2136729919375;3575.106223444139;3581.3732596795458;3586.8206589670413;30887.073387798402;31160.065198044096;31246.21884452884;31327.216819579466;31361.215969600715;4995.925061124086;5156.407013193493;5203.9219411708855;5327.121025030865;5402.702851343174;192931;193263;193356;194425;194595.02702486538;42042.57957420448;42812.35781463281;48977.755111224214;48994.51005489971;49040.50959490431;52091.73954130205;53486.465135348924;53768.731156343965;53870;53882.46117538775;16497.422590209284;16601.41895033668;16644.167791610373;16652.58368540772;16676.16619169037;13507.864921350661;13511.527096551574;13512.189268643913;13515.662108447172;13521.526746563823;14222.857771422154;14252.501162459264;14262.857371426153;14333.354999025069;14402.279886005657;5757.424257574209;5796.710164491843;5839.416058394127;5847.152162936351;5872.383399742966;1010.1413798271558;1014.6550172941236;1020.3163880200284;1030.90206430389;1038.787048655024;22838.771612283996;23057.654135187986;23165.7683423167;23210.65184022241;23365.41586460352;1109.367660433545;1117.5529788084832;1124.128800179867;1128.4639796096953;1138.6299452677913;12181.512739490321;12227.510899563918;12227.633171004883;12288;12323.383830808423;224500;225723;226148;227457;228420;52587;52635.73682131565;52711.472885270654;52945.7352713234;53045.204321935205;1425.3701919957869;1454.6872422429228;1466.288849907794;1472.2859413184597;1480.0897448069359;22350;22600.321990340315;22663.19735215565;22934.19730309431;23200.3039908803;37172.256554869295;37480.06299842417;37572.060698482754;37581;37727;194784;196636;197070;198081;198421;31215.063548093593;31519.527207091454;34111.65888341085;34466;34653.48019779655;42288.577114228465;42546.57453425426;42741.35887961745;43501.56498435102;43738;30875;31150;31158.37683246277;31521.52717709282;31785;30643.54034689526;31052.22369440782;31115.84442077775;31277.84361078271;31412.371752564362;35366.29267414586;35574.82212588921;36123.916282510516;36178.45732313965;36232.63767362293;29336.55995160117;30648;30669.23326916756;30896.227594309425;31412.685873140977;22878.65682014738;22995.754276905016;23269.3019209424;23811.523769524858;23994.76005239995 00:24:10 INFO - PID 3316 | |2;jquery.html;533.1389805464177;538.8949154914793;545.8362491252626;566.806459003656;567.5980328588387;21761.891190544044;22496.8875155624;22499.21252756154;22523.887380563076;22547.887260563693;23653.172138975096;24443.75556244437;24757.38106547337;24784.628230576556;25395.238142855746;6171.969140154293;6235.781747638811;6294.402031806971;6318.052292156168;6320.367963203666;6285.088662143987;6356.777512787054;6380.489560835122;6382.074599183115;6388.968055159718;6326.68366581669;6344.587601805868;6354.555181137299;6360.204974378203;6360.2367715873925;6573.671316434207;6580.80257592273;6609.239937407187;6611.107500487421;6612.801615951529;6097.664628445434;6105.481034112106;6130.1724267224245;6134.662593557353;6150.477209437203;27955.58066629002;28477;28653.426931461254;29310.560341594894;29324.853375733197;1994.351835653404;2038.7553493580717;2040.6224848403092;2053.209514336976;2056.321413933398;19571.21715131393;19841.404757857286;19923.10346034432;19939.401817945483;20006.299779507648;2424.2000139953775;2459.655648209252;2505.736897625741;2509.6737424134926;2517.320323512641;112522;118706;136471;138362.3081884584;144716;14552.345144468525;14589.756192008042;14712.926435367755;14737.852621473863;15001.774973375408;22085.779142208692;22105.557888842133;22251.666225006637;22403.887980559994;22435.439114021952;10129.898701013042;10245.436500992368;10251.538680759235;10319.535620897077;10488.475576221159;9725.367851089657;9768.853467197856;9818.607255709692;9823.214142868554;9930.751731206634;8859.64561417549;9110.633404989305;9131.954340228256;9235.12266334697;9264.67573634933;2691.9596206056926;2764.087851009162;2768.404792969521;2771.3348796288747;2866.971330286712;944.7779771753633;972.7130496503548;980.7989362180735;985.0445068283753;995.4922989275377;19262.17009384106;19327.226910923688;19339.709904351446;19461.12424940881;19707.507312317306;1045.7072019834307;1048.7745134796055;1052.2634156090767;1054.2462139570243;1055.5672174408455;10750.301230419998;10775.245732798629;10835.51240194193;10992.626714326232;11226.101911847032;451753;452666;464782;470504;473793;111614;112646;112954.43522782334;113640.43179784213;114336.42831785788;1168.9240199387013;1181.2912252648514;1235.1473530792296;1248.8001919692806;1253.7241806802672;20792.37622871316;20980.58038839184;21372.57254854863;21386.465338366666;21450.141994320053;54864.17703734527;55148.72425637846;55201.171982421096;56049;56502.71748641231;67063.66468167628;67723;68281.31718682949;68287.65856170886;69303.65348173227;14113.2237726926;14261.857381426053;14286.357113929691;14363.281835908372;14402;22873.771262287828;22923.541529169655;22982.770172298733;23204.3038708839;23301.883490582437;18207.180676869837;18334.724979125058;18553.2578696856;18586;18727.157277922255;16606.50180494587;16829.74755378646;16948.661026779642;17046.82953170502;17094.145292735564;17904.820951790316;18380.356687515872;18595.34916277924;18762.624747505248;18816.153273103017;13952.58142255734;14176.645583860485;14225.430982760574;14229.217393043067;14349.497767578503;17850.821491784915;18052.458426247234;18520;18675.06624668734;18680.25278988825 00:24:10 INFO - PID 3316 | |3;mootools.html;1299;1352.1549031855097;1356.681179922718;1360.16349944784;1360.9523666671669;14925;15467.845321546782;15526.146061966587;15586.220688965563;15623.062616243033;15115.39538418462;15152.545423637308;15295.541133766004;15397.153156576383;15461.22693865305;2554.846709197454;2565.551028570002;2591.7926565874686;2602.349412646838;2605.2054123492326;2530.860802655853;2542.1229675761833;2587.4695687384137;2592.3648706066947;2598.0387256715044;2623.868806559674;2768.792340574455;2769.2246171072034;2801.1876555798895;2804.242854429303;2772.88908443662;2774.1954833098375;2811.283122803682;2814.549672052482;2815.591739197815;2579.548578998668;2718.510668079765;2730.2082396105106;2741.4517096580566;2756.0629386008654;15242.923785381114;15349.616259593487;15365.539033829004;15367.15480648564;15381.307841147063;7975.920240797575;8135.023797144321;8195.221453961924;8195.303399211074;8198;5106.131957567222;5245.396779370345;5306.814261500867;5348.866278343073;5355.892882142335;1810.1582764014665;1815.8365747082826;1843.1982087791853;1876.1088482970615;1879.6146789908037;25975.74024259752;26104.8694756525;26224.475510489683;26240.60639090415;26276.86861565699;6612.669366531654;6690.732370705215;6752.831179220559;6916.4092258780765;6919.930800692029;16982.490525284262;16996.915015424845;17040.233189506504;17070.317187312616;17196.22616982239;7775.49459285156;7857.1357150713375;7869.881951770728;7941;7970.163132871081;6985;7189.532680375759;7192.676329565182;7348.412127029825;7376.0411146550605;5116.923246151311;5321.787128514893;5337.466253374709;5339.786408543615;5586.217929489874;1549.6978089272484;1562.312582463735;1563.265265325318;1563.7498000320122;1565.0687840734745;841.1504380575662;845.4800297816921;863.6674880171054;867.2324992381662;870.8084221471266;6812;6821.556598821061;6874.037634731141;7929.207079292025;8130.471519351223;699.9790006299819;708.2492557888654;716.2694052066863;720.3660778514978;721.4192574977089;4716.834910778106;4949.232868905326;5043.5460808527405;5050.217216331474;5115.462876397999;20461.89769051175;20859.478513037295;21654.675179872316;21714.891425543086;21737.67393489099;20858.165673373198;21350.78649213519;21392.679109813365;21406.785932140792;21409.571808564055;9371.578278977326;9945.055219754111;10090.646827361006;10100.747481313027;10116.291859569907;7890.289873911375;7898.921010789819;7907.2488113629115;7986.880196796937;7997.280244777998;17788.46634600964;18234.635307293516;18493.72259416137;18689.719654204924;18751.624967500848;18712.25150993945;18980.715289270396;19101.808981910002;19157.329493467663;19260.614787704446;10587.576496940035;10838.187135964676;10876.945615271872;10955.233133680566;11029.503672334604;13563.86436135626;13768.862311376757;13772.65568360799;13774.311284435538;13779.586612401645;10576.894231057591;10693.732656683645;10801.243912926335;10912.181586380895;10985.066269367193;10010.299279050396;10284.074433301039;10349.344104943173;10550.947245263724;10589.894101058891;9189;9284.767880803034;9421.434713917188;9488.667896623585;9493.525323733647;6771.898421523582;6915.930840691529;6950.443964482931;6983.790486285419;7001.054857594363;6670;6719.428848547928;6723.596584204964;6733.528652994243;6773.322667733188 00:24:10 INFO - PID 3316 | |4;prototype.html;465.13717054863247;468.4519112638213;491.40539946664535;510.9182530795072;515.6648178683855;6141.72362243699;6185.9999999999945;6243.282022567406;6268.65522396268;6306.495480361572;6137.355577664348;6157.322694503601;6164.229471316085;6184.257889053309;6201.906971395421;5085.211792172219;5097.770600322985;5122.718250496221;5129.615278854082;5132;4995.125852975733;5041.218611115265;5070.873228169288;5096.949030509703;5104.208847628605;4698.765061746916;4811.4707382187935;4908.779104940269;4919.360483137187;4934.333864928225;4821.710697358169;4854.393200849894;4856.465788763233;4894.608431325485;4925.975370123145;4339.153864996327;4363.36731173978;4387.617900361376;4396.230659634583;4412.6690498212765;5852;5988.610740301867;5990.161377407167;6054.848628784272;6058.909116363258;5555.666660000373;5586.078297080977;5587.692676902769;5608.10270356741;5626.240457538262;6434.871302573969;6437.130987316699;6455.9354406455805;6467.383154211447;6483.286838447767;4570.925832429376;4785.95214047862;4791.544803243686;4800.0879832832;4834;6544.541882068257;6622.377517508193;6632.502562307846;6774.898376524356;6789.422899053537;4891.951080489221;4892.804287828447;4895.069936712013;4906.730129842822;4929.75351232437;4921.7785199666105;4984.700917944935;4999.375078115236;5007.87008119925;5038.773255203525;5541.254504830966;5568.853597717277;5612.130119831432;5622.718864056781;5627.409122042209;6491.344707099754;6518.804435866931;6520.282768895418;6529.8694026120165;6550.246721627074;1707.6072503324306;1711.4266720648473;1732.6534693061185;1735.158448152645;1752.229019231534;1132.1735133352533;1195.491915935724;1213.7875871722413;1214.2532342609409;1229.7479016801535;5517.475839795213;5589.357223919302;5616.550675945915;5644.814588936288;5682.215714299963;6505.902411463831;6512.869742605121;6544.247411547638;6553.770618028441;6608.504362172856;5602.747876345574;5609.960828203687;5659.236003139606;5662.725886675547;5698.6580805151825;3470.7396945229207;3478.756487045933;3504.6857428464327;3531.346700860349;3537.1864471171775;6305.369463053658;6347.460465860361;6399.9040014399825;6411.743530258737;6419.967900160469;6672.766453174116;6701.5308928375525;6773.9322606774285;6778.7288508459105;6809.829754256084;6285.654289014148;6297.307296197415;6352.474376720964;6394.424501794861;6403.551751377452;5922.822315330547;6334.194754494947;6363.391009686006;6504.447121994684;6529.67351632426;6332.810015699536;6359.427651511386;6359.87280254383;6378.617282963037;6499.902501462388;6133.466633341664;6200.689965501617;6215.223097112861;6238.344973777688;6315.463185629273;4845.200541910545;4854.320395144612;4869.172240719157;4893.192623217129;4918.778654960463;6282.937170628235;6370.362963703593;6552.3775241352;6557.409833115043;6676.365745254193;6356.396142366468;6366.427021568081;6386.9680651596445;6477.902831457438;6515.413612774873;6295.527835412271;6347.968260158855;6355.3326900674765;6392.232932048184;6423.454006409321;6153.077038444269;6318.715657795502;6337.7781777637565;6363.745450181941;6366.981282994699;6404.807855764335;6476.158099447231;6482.384173503509;6506.284308725942;6520.598071414669;6225.252969643671;6231.9688401557705;6253.96873015632;6299.811005669837;6322.652254126067 00:24:10 INFO - PID 3316 | |5;yui.html;835.4444294544129;851.4252879306468;889.7508697564684;899.6131663384746;926.6849271247775;19086.522836929067;19791.307304244354;19964.70052949207;19993.10031048601;20020.79875207487;18156.18297176627;18619.255229790793;18806.90596547019;19225.519362015955;19300;964.3201542912248;974.0843607009424;977.4184360305607;977.9511024448784;979.4172467381896;966.1160038564705;980.4999450280337;981.293468702533;981.411153308013;982.5873133284038;999.1207737191298;1021.1983592879591;1025.646152077532;1025.784585237101;1026.271347343387;1023.483141013787;1023.918086553074;1024.2164743970905;1025.6974192613197;1026.7330494071557;720.6576875983918;748.2629609834308;751.0161688188491;751.8721817291074;754.5133388964142;19963.401097967086;20230.190792368434;20241.392758217276;20369.8981505093;20464;21501.247456339108;21586.676199857015;22280.554388912293;22358.55282894333;22508.549829003492;17523.824761752476;17544.91227543867;17717.911410442994;17813.46559603214;17886.016269105196;3679.4848721178787;3717.5353080864893;3730.2725968436166;3754.1928485375774;3763.435484677293;137405;138304.30847845797;140939.29530352386;141192;143116.2844185783;16791.832081679273;17012;17152.456278934955;17268.99999999975;17388.391406300718;30860.84569577138;31630.367392652017;31809;32003.51994720081;32096.518552221736;7940.801479962932;7966.283034526805;7987;8006.1993800619475;8024.197580242046;4061.2080644274083;4103.610157035077;4106.630403263661;4181.790910454526;4186.518550366686;5419.512243898068;5589.273394458775;5600.439956004367;5622.746976386073;5625.578081643893;939.534930209537;958.2765012415582;968.4479846487575;972.0571046085286;977.237754551451;691.1395312835552;705.8694141583824;715.3025799845213;715.9046658612332;725.365305357812;11227.775444491064;11289;11667.766644667228;11848.70378240551;12106.515739370503;664.1532046640475;671.9798406047827;672.9495287853431;682.7507959594712;688.9183981149647;5253.789848406097;5295.205719142159;5305.257263983045;5312.73436328182;5482.80810171642;122889;123009;124961.37519312528;127402;127696;107346.46326768317;109691.45154274337;110420.44789776161;112727.43636281767;113294.43352783348;88656.55671721729;89634.10365896388;92081.07918920858;92108;92456;9674.129328360481;9725.610975561181;9743.707688769347;9804.068613481708;9825.017498250403;43171.78414107909;44282.3357649629;44365.556344437435;44812.77593612011;45265.32102018406;54279.18581221364;54331.45668543264;55050.724746377615;55103.724481377336;56609.433905660415;15784.21078946071;16001.599960001093;16077.75883361727;16142;16165.59586010359;17089.060101694526;17145.571360716083;17252.22364993553;17424.303027878745;17494.825051749318;15997.360105595646;16010.439634612732;16047.679046418772;16105.516834494983;16144.596385090466;15571.610709731895;15935.840641593899;15981;16003.519894403187;16131.354745810506;14803.407863685332;14807.185604791839;14888.25558722038;14979.475718349806;15089.170095644846;11756.94121529387;11849.466773995364;11937.164398492023;12162.087843411602;12224.266544007389;11503.079753619522;11625.18623696333;11722.120840937134;11726.824097638371;12018.879811201776 00:24:10 INFO - PID 3316 | __end_tp_report 00:24:10 INFO - PID 3316 | __start_cc_report 00:24:10 INFO - PID 3316 | _x_x_mozilla_cycle_collect,369 00:24:10 INFO - PID 3316 | __end_cc_report 00:24:10 INFO - PID 3316 | __startTimestamp1505373850041__endTimestamp 00:24:10 INFO - PID 3316 | 00:24:10 INFO - PID 3316 | ------- Summary: start ------- 00:24:10 INFO - PID 3316 | Number of tests: 6 00:24:10 INFO - PID 3316 | 00:24:10 INFO - PID 3316 | [#0] dojo.html Cycles:165 Average:6099.00 Median:6333.71 stddev:748.74 (11.8%) stddev-sans-first:713.11 00:24:10 INFO - PID 3316 | Values: 3099.7 3120.2 3120.9 3128.0 3132.4 6017.1 6135.2 6142.9 6221.1 6266.6 6105.3 6164.5 6196.3 6210.3 6238.2 5721.7 5726.5 5747.4 5759.2 5794.1 5685.2 5763.8 5767.4 5792.9 5803.4 5691.2 5723.7 5725.8 5751.7 5793.2 5742.2 5748.5 5764.0 5818.9 5841.9 5251.5 5513.7 5591.4 5607.0 5623.2 6082.8 6124.2 6243.9 6254.3 6255.5 6522.8 6554.9 6625.9 6632.9 6718.0 6677.5 6694.7 6719.9 6721.1 6735.1 6157.0 6171.7 6228.2 6249.4 6257.9 6806.6 6862.4 6867.1 6889.4 6914.4 6261.8 6390.6 6435.9 6580.5 6623.2 6620.3 6670.0 6687.5 6723.2 6753.9 6597.3 6640.9 6698.3 6719.4 6734.4 6661.1 6661.6 6731.0 6744.1 6749.8 5006.7 5080.2 5080.5 5086.9 5150.1 4472.5 4501.6 4508.2 4526.0 4594.3 5616.7 5667.2 5702.7 5713.1 5728.3 6616.7 6619.4 6627.3 6637.2 6651.2 5674.3 5686.6 5697.5 5707.5 5718.9 5475.2 5592.2 5606.0 5617.3 5632.6 6349.4 6413.6 6476.3 6503.3 6532.2 6650.2 6653.4 6725.3 6727.6 6777.8 6280.5 6406.0 6420.7 6440.8 6455.4 6550.3 6570.5 6575.6 6588.2 6603.3 6608.9 6747.9 6757.3 6766.8 6767.7 6443.3 6447.6 6517.6 6526.6 6530.4 6313.8 6333.7 6354.4 6419.2 6471.0 6343.2 6395.9 6413.9 6423.7 6427.3 6464.4 6500.9 6505.1 6590.2 6601.7 6136.8 6250.4 6265.1 6275.6 6339.4 00:24:10 INFO - PID 3316 | 00:24:10 INFO - PID 3316 | [#1] ext.html Cycles:180 Average:37392.73 Median:19454.39 stddev:53409.15 (274.5%) stddev-sans-first:53488.28 00:24:10 INFO - PID 3316 | Values: 795.7 820.2 822.0 822.6 825.8 38371.0 41522.4 41852.8 41874.2 42152.4 38575.4 38645.2 38959.2 38984.6 39051.0 6966.4 7033.2 7073.3 7083.4 7560.1 7657.5 7777.0 7846.7 7847.4 7847.7 7829.3 7842.2 7842.6 7852.9 7917.7 7739.7 7782.6 7824.3 7832.7 7842.8 7733.8 7772.3 7775.9 7796.7 7797.2 39086.0 39268.8 39355.6 39395.6 39417.2 3542.5 3574.2 3575.1 3581.4 3586.8 30887.1 31160.1 31246.2 31327.2 31361.2 4995.9 5156.4 5203.9 5327.1 5402.7 192931.0 193263.0 193356.0 194425.0 194595.0 42042.6 42812.4 48977.8 48994.5 49040.5 52091.7 53486.5 53768.7 53870.0 53882.5 16497.4 16601.4 16644.2 16652.6 16676.2 13507.9 13511.5 13512.2 13515.7 13521.5 14222.9 14252.5 14262.9 14333.4 14402.3 5757.4 5796.7 5839.4 5847.2 5872.4 1010.1 1014.7 1020.3 1030.9 1038.8 22838.8 23057.7 23165.8 23210.7 23365.4 1109.4 1117.6 1124.1 1128.5 1138.6 12181.5 12227.5 12227.6 12288.0 12323.4 224500.0 225723.0 226148.0 227457.0 228420.0 52587.0 52635.7 52711.5 52945.7 53045.2 1425.4 1454.7 1466.3 1472.3 1480.1 22350.0 22600.3 22663.2 22934.2 23200.3 37172.3 37480.1 37572.1 37581.0 37727.0 194784.0 196636.0 197070.0 198081.0 198421.0 31215.1 31519.5 34111.7 34466.0 34653.5 42288.6 42546.6 42741.4 43501.6 43738.0 30875.0 31150.0 31158.4 31521.5 31785.0 30643.5 31052.2 31115.8 31277.8 31412.4 35366.3 35574.8 36123.9 36178.5 36232.6 29336.6 30648.0 30669.2 30896.2 31412.7 22878.7 22995.8 23269.3 23811.5 23994.8 00:24:10 INFO - PID 3316 | 00:24:10 INFO - PID 3316 | [#2] jquery.html Cycles:180 Average:33595.23 Median:22466.16 stddev:78012.74 (347.2%) stddev-sans-first:78192.10 00:24:10 INFO - PID 3316 | Values: 533.1 538.9 545.8 566.8 567.6 21761.9 22496.9 22499.2 22523.9 22547.9 23653.2 24443.8 24757.4 24784.6 25395.2 6172.0 6235.8 6294.4 6318.1 6320.4 6285.1 6356.8 6380.5 6382.1 6389.0 6326.7 6344.6 6354.6 6360.2 6360.2 6573.7 6580.8 6609.2 6611.1 6612.8 6097.7 6105.5 6130.2 6134.7 6150.5 27955.6 28477.0 28653.4 29310.6 29324.9 1994.4 2038.8 2040.6 2053.2 2056.3 19571.2 19841.4 19923.1 19939.4 20006.3 2424.2 2459.7 2505.7 2509.7 2517.3 112522.0 118706.0 136471.0 138362.3 144716.0 14552.3 14589.8 14712.9 14737.9 15001.8 22085.8 22105.6 22251.7 22403.9 22435.4 10129.9 10245.4 10251.5 10319.5 10488.5 9725.4 9768.9 9818.6 9823.2 9930.8 8859.6 9110.6 9132.0 9235.1 9264.7 2692.0 2764.1 2768.4 2771.3 2867.0 944.8 972.7 980.8 985.0 995.5 19262.2 19327.2 19339.7 19461.1 19707.5 1045.7 1048.8 1052.3 1054.2 1055.6 10750.3 10775.2 10835.5 10992.6 11226.1 451753.0 452666.0 464782.0 470504.0 473793.0 111614.0 112646.0 112954.4 113640.4 114336.4 1168.9 1181.3 1235.1 1248.8 1253.7 20792.4 20980.6 21372.6 21386.5 21450.1 54864.2 55148.7 55201.2 56049.0 56502.7 67063.7 67723.0 68281.3 68287.7 69303.7 14113.2 14261.9 14286.4 14363.3 14402.0 22873.8 22923.5 22982.8 23204.3 23301.9 18207.2 18334.7 18553.3 18586.0 18727.2 16606.5 16829.7 16948.7 17046.8 17094.1 17904.8 18380.4 18595.3 18762.6 18816.2 13952.6 14176.6 14225.4 14229.2 14349.5 17850.8 18052.5 18520.0 18675.1 18680.3 00:24:10 INFO - PID 3316 | 00:24:10 INFO - PID 3316 | [#3] mootools.html Cycles:180 Average:9126.55 Median:26164.67 stddev:6623.84 (25.3%) stddev-sans-first:6616.31 00:24:10 INFO - PID 3316 | Values: 1299.0 1352.2 1356.7 1360.2 1361.0 14925.0 15467.8 15526.1 15586.2 15623.1 15115.4 15152.5 15295.5 15397.2 15461.2 2554.8 2565.6 2591.8 2602.3 2605.2 2530.9 2542.1 2587.5 2592.4 2598.0 2623.9 2768.8 2769.2 2801.2 2804.2 2772.9 2774.2 2811.3 2814.5 2815.6 2579.5 2718.5 2730.2 2741.5 2756.1 15242.9 15349.6 15365.5 15367.2 15381.3 7975.9 8135.0 8195.2 8195.3 8198.0 5106.1 5245.4 5306.8 5348.9 5355.9 1810.2 1815.8 1843.2 1876.1 1879.6 25975.7 26104.9 26224.5 26240.6 26276.9 6612.7 6690.7 6752.8 6916.4 6919.9 16982.5 16996.9 17040.2 17070.3 17196.2 7775.5 7857.1 7869.9 7941.0 7970.2 6985.0 7189.5 7192.7 7348.4 7376.0 5116.9 5321.8 5337.5 5339.8 5586.2 1549.7 1562.3 1563.3 1563.7 1565.1 841.2 845.5 863.7 867.2 870.8 6812.0 6821.6 6874.0 7929.2 8130.5 700.0 708.2 716.3 720.4 721.4 4716.8 4949.2 5043.5 5050.2 5115.5 20461.9 20859.5 21654.7 21714.9 21737.7 20858.2 21350.8 21392.7 21406.8 21409.6 9371.6 9945.1 10090.6 10100.7 10116.3 7890.3 7898.9 7907.2 7986.9 7997.3 17788.5 18234.6 18493.7 18689.7 18751.6 18712.3 18980.7 19101.8 19157.3 19260.6 10587.6 10838.2 10876.9 10955.2 11029.5 13563.9 13768.9 13772.7 13774.3 13779.6 10576.9 10693.7 10801.2 10912.2 10985.1 10010.3 10284.1 10349.3 10550.9 10589.9 9189.0 9284.8 9421.4 9488.7 9493.5 6771.9 6915.9 6950.4 6983.8 7001.1 6670.0 6719.4 6723.6 6733.5 6773.3 00:24:10 INFO - PID 3316 | 00:24:10 INFO - PID 3316 | [#4] prototype.html Cycles:180 Average:5402.39 Median:6096.19 stddev:1505.05 (24.7%) stddev-sans-first:1462.94 00:24:10 INFO - PID 3316 | Values: 465.1 468.5 491.4 510.9 515.7 6141.7 6186.0 6243.3 6268.7 6306.5 6137.4 6157.3 6164.2 6184.3 6201.9 5085.2 5097.8 5122.7 5129.6 5132.0 4995.1 5041.2 5070.9 5096.9 5104.2 4698.8 4811.5 4908.8 4919.4 4934.3 4821.7 4854.4 4856.5 4894.6 4926.0 4339.2 4363.4 4387.6 4396.2 4412.7 5852.0 5988.6 5990.2 6054.8 6058.9 5555.7 5586.1 5587.7 5608.1 5626.2 6434.9 6437.1 6455.9 6467.4 6483.3 4570.9 4786.0 4791.5 4800.1 4834.0 6544.5 6622.4 6632.5 6774.9 6789.4 4892.0 4892.8 4895.1 4906.7 4929.8 4921.8 4984.7 4999.4 5007.9 5038.8 5541.3 5568.9 5612.1 5622.7 5627.4 6491.3 6518.8 6520.3 6529.9 6550.2 1707.6 1711.4 1732.7 1735.2 1752.2 1132.2 1195.5 1213.8 1214.3 1229.7 5517.5 5589.4 5616.6 5644.8 5682.2 6505.9 6512.9 6544.2 6553.8 6608.5 5602.7 5610.0 5659.2 5662.7 5698.7 3470.7 3478.8 3504.7 3531.3 3537.2 6305.4 6347.5 6399.9 6411.7 6420.0 6672.8 6701.5 6773.9 6778.7 6809.8 6285.7 6297.3 6352.5 6394.4 6403.6 5922.8 6334.2 6363.4 6504.4 6529.7 6332.8 6359.4 6359.9 6378.6 6499.9 6133.5 6200.7 6215.2 6238.3 6315.5 4845.2 4854.3 4869.2 4893.2 4918.8 6282.9 6370.4 6552.4 6557.4 6676.4 6356.4 6366.4 6387.0 6477.9 6515.4 6295.5 6348.0 6355.3 6392.2 6423.5 6153.1 6318.7 6337.8 6363.7 6367.0 6404.8 6476.2 6482.4 6506.3 6520.6 6225.3 6232.0 6254.0 6299.8 6322.7 00:24:10 INFO - PID 3316 | 00:24:10 INFO - PID 3316 | [#5] yui.html Cycles:180 Average:24275.92 Median:21933.62 stddev:35405.77 (161.4%) stddev-sans-first:35461.34 00:24:10 INFO - PID 3316 | Values: 835.4 851.4 889.8 899.6 926.7 19086.5 19791.3 19964.7 19993.1 20020.8 18156.2 18619.3 18806.9 19225.5 19300.0 964.3 974.1 977.4 978.0 979.4 966.1 980.5 981.3 981.4 982.6 999.1 1021.2 1025.6 1025.8 1026.3 1023.5 1023.9 1024.2 1025.7 1026.7 720.7 748.3 751.0 751.9 754.5 19963.4 20230.2 20241.4 20369.9 20464.0 21501.2 21586.7 22280.6 22358.6 22508.5 17523.8 17544.9 17717.9 17813.5 17886.0 3679.5 3717.5 3730.3 3754.2 3763.4 137405.0 138304.3 140939.3 141192.0 143116.3 16791.8 17012.0 17152.5 17269.0 17388.4 30860.8 31630.4 31809.0 32003.5 32096.5 7940.8 7966.3 7987.0 8006.2 8024.2 4061.2 4103.6 4106.6 4181.8 4186.5 5419.5 5589.3 5600.4 5622.7 5625.6 939.5 958.3 968.4 972.1 977.2 691.1 705.9 715.3 715.9 725.4 11227.8 11289.0 11667.8 11848.7 12106.5 664.2 672.0 672.9 682.8 688.9 5253.8 5295.2 5305.3 5312.7 5482.8 122889.0 123009.0 124961.4 127402.0 127696.0 107346.5 109691.5 110420.4 112727.4 113294.4 88656.6 89634.1 92081.1 92108.0 92456.0 9674.1 9725.6 9743.7 9804.1 9825.0 43171.8 44282.3 44365.6 44812.8 45265.3 54279.2 54331.5 55050.7 55103.7 56609.4 15784.2 16001.6 16077.8 16142.0 16165.6 17089.1 17145.6 17252.2 17424.3 17494.8 15997.4 16010.4 16047.7 16105.5 16144.6 15571.6 15935.8 15981.0 16003.5 16131.4 14803.4 14807.2 14888.3 14979.5 15089.2 11756.9 11849.5 11937.2 12162.1 12224.3 11503.1 11625.2 11722.1 11726.8 12018.9 00:24:10 INFO - PID 3316 | -------- Summary: end -------- 00:24:10 INFO - PID 3316 | 00:24:10 INFO - TEST-INFO | 3316: exit 0 00:24:10 INFO - TEST-OK | dromaeo_css | took 1114519ms 00:24:10 INFO - TEST-START | kraken 00:24:10 INFO - Initialising browser for kraken test... 00:24:10 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:46372/getInfo.html -profile /tmp/tmpqP4noC/profile 00:24:10 INFO - TEST-INFO | started process 3707 (/builds/slave/test/build/application/firefox/firefox http://localhost:46372/getInfo.html) 00:24:16 INFO - TEST-INFO | 3707: exit 0 00:24:16 INFO - Browser initialized. 00:24:16 INFO - Running cycle 1/1 for kraken test... 00:24:16 INFO - Using env: {'DISPLAY': ':0', 00:24:16 INFO - 'HOME': '/home/cltbld', 00:24:16 INFO - 'JSGC_DISABLE_POISONING': '1', 00:24:16 INFO - 'LANG': 'en_US.UTF-8', 00:24:16 INFO - 'LANGUAGE': 'en_US:en', 00:24:16 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 00:24:16 INFO - 'LOGNAME': 'cltbld', 00:24:16 INFO - 'MAIL': '/var/mail/cltbld', 00:24:16 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 00:24:16 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 00:24:16 INFO - 'MOZ_ACCELERATED': '1', 00:24:16 INFO - 'MOZ_CRASHREPORTER': '1', 00:24:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:24:16 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 00:24:16 INFO - 'MOZ_NO_REMOTE': '1', 00:24:16 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 00:24:16 INFO - 'MOZ_WEBRENDER': '1', 00:24:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:24:16 INFO - 'NO_EM_RESTART': '1', 00:24:16 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:24:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:24:16 INFO - 'PWD': '/builds/slave/test', 00:24:16 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 00:24:16 INFO - 'RUST_BACKTRACE': 'full', 00:24:16 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 00:24:16 INFO - 'SHELL': '/bin/bash', 00:24:16 INFO - 'SHLVL': '1', 00:24:16 INFO - 'TERM': 'linux', 00:24:16 INFO - 'TMOUT': '86400', 00:24:16 INFO - 'USER': 'cltbld', 00:24:16 INFO - 'XDG_SESSION_COOKIE': '51fc86400edbde9650d2781a000001d0-1505370572.267818-213713610', 00:24:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:24:16 INFO - '_': '/tools/buildbot/bin/python'} 00:24:16 INFO - TEST-INFO | started process 3950 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqP4noC/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 00:24:17 INFO - PID 3950 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 00:24:17 INFO - PID 3950 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 00:24:18 INFO - PID 3950 | 00:24:18 INFO - PID 3950 | (/builds/slave/test/build/application/firefox/firefox:4009): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 00:24:18 INFO - PID 3950 | 00:24:28 INFO - PID 3950 | RSS: Main: 218484736 00:24:28 INFO - PID 3950 | 00:24:31 INFO - PID 3950 | Cycle 1(1): loaded http://localhost:46372/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:46372/tests/kraken/driver.html?testName=audio-beat-detection) 00:24:32 INFO - PID 3950 | RSS: Main: 225239040 00:24:32 INFO - PID 3950 | 00:24:34 INFO - PID 3950 | Cycle 1(1): loaded http://localhost:46372/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:46372/tests/kraken/driver.html?testName=audio-dft) 00:24:35 INFO - PID 3950 | RSS: Main: 224722944 00:24:35 INFO - PID 3950 | 00:24:38 INFO - PID 3950 | Cycle 1(1): loaded http://localhost:46372/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:46372/tests/kraken/driver.html?testName=audio-fft) 00:24:39 INFO - PID 3950 | RSS: Main: 220176384 00:24:39 INFO - PID 3950 | 00:24:41 INFO - PID 3950 | Cycle 1(1): loaded http://localhost:46372/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:46372/tests/kraken/driver.html?testName=audio-oscillator) 00:24:41 INFO - PID 3950 | RSS: Main: 220618752 00:24:41 INFO - PID 3950 | 00:24:44 INFO - PID 3950 | Cycle 1(1): loaded http://localhost:46372/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:46372/tests/kraken/driver.html?testName=imaging-gaussian-blur) 00:24:44 INFO - PID 3950 | RSS: Main: 221929472 00:24:44 INFO - PID 3950 | 00:24:48 INFO - PID 3950 | Cycle 1(1): loaded http://localhost:46372/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:46372/tests/kraken/driver.html?testName=imaging-darkroom) 00:24:48 INFO - PID 3950 | RSS: Main: 225140736 00:24:48 INFO - PID 3950 | 00:24:52 INFO - PID 3950 | Cycle 1(1): loaded http://localhost:46372/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:46372/tests/kraken/driver.html?testName=imaging-desaturate) 00:24:52 INFO - PID 3950 | RSS: Main: 222990336 00:24:52 INFO - PID 3950 | 00:24:56 INFO - PID 3950 | Cycle 1(1): loaded http://localhost:46372/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:46372/tests/kraken/driver.html?testName=json-parse-financial) 00:24:56 INFO - PID 3950 | RSS: Main: 223748096 00:24:56 INFO - PID 3950 | 00:24:58 INFO - PID 3950 | Cycle 1(1): loaded http://localhost:46372/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:46372/tests/kraken/driver.html?testName=json-stringify-tinderbox) 00:24:58 INFO - PID 3950 | RSS: Main: 225439744 00:24:58 INFO - PID 3950 | 00:25:00 INFO - PID 3950 | Cycle 1(1): loaded http://localhost:46372/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:46372/tests/kraken/driver.html?testName=stanford-crypto-aes) 00:25:01 INFO - PID 3950 | RSS: Main: 220868608 00:25:01 INFO - PID 3950 | 00:25:03 INFO - PID 3950 | Cycle 1(1): loaded http://localhost:46372/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:46372/tests/kraken/driver.html?testName=stanford-crypto-ccm) 00:25:04 INFO - PID 3950 | RSS: Main: 221605888 00:25:04 INFO - PID 3950 | 00:25:06 INFO - PID 3950 | Cycle 1(1): loaded http://localhost:46372/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:46372/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 00:25:07 INFO - PID 3950 | RSS: Main: 222965760 00:25:07 INFO - PID 3950 | 00:25:10 INFO - PID 3950 | Cycle 1(1): loaded http://localhost:46372/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:46372/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 00:25:11 INFO - PID 3950 | RSS: Main: 222330880 00:25:11 INFO - PID 3950 | 00:25:12 INFO - PID 3950 | Cycle 1(1): loaded http://localhost:46372/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:46372/tests/kraken/driver.html?testName=ai-astar) 00:25:13 INFO - PID 3950 | RSS: Main: 225079296 00:25:13 INFO - PID 3950 | 00:25:13 INFO - PID 3950 | __start_tp_report 00:25:13 INFO - PID 3950 | _x_x_mozilla_page_load 00:25:13 INFO - PID 3950 | _x_x_mozilla_page_load_details 00:25:13 INFO - PID 3950 | |i|pagename|runs| 00:25:13 INFO - PID 3950 | |0;ai-astar;111;108;114;108;108;107;109;109;108;109 00:25:13 INFO - PID 3950 | |1;audio-beat-detection;126;118;118;119;123;115;139;121;133;126 00:25:13 INFO - PID 3950 | |2;audio-dft;164;163;163;167;163;169;174;166;166;165 00:25:13 INFO - PID 3950 | |3;audio-fft;80;84;78;77;75;73;75;81;77;78 00:25:13 INFO - PID 3950 | |4;audio-oscillator;81;88;80;78;81;82;82;82;86;80 00:25:13 INFO - PID 3950 | |5;imaging-gaussian-blur;114;114;115;114;111;115;114;116;111;118 00:25:13 INFO - PID 3950 | |6;imaging-darkroom;148;154;149;147;147;148;148;148;155;155 00:25:13 INFO - PID 3950 | |7;imaging-desaturate;95;99;96;95;97;95;95;95;100;96 00:25:13 INFO - PID 3950 | |8;json-parse-financial;65;58;52;54;55;51;52;52;63;52 00:25:13 INFO - PID 3950 | |9;json-stringify-tinderbox;42;46;48;48;41;45;45;40;42;46 00:25:13 INFO - PID 3950 | |10;stanford-crypto-aes;82;85;77;80;73;76;75;76;74;79 00:25:13 INFO - PID 3950 | |11;stanford-crypto-ccm;118;120;110;122;117;119;117;120;122;118 00:25:13 INFO - PID 3950 | |12;stanford-crypto-pbkdf2;175;167;172;168;172;167;168;167;171;169 00:25:13 INFO - PID 3950 | |13;stanford-crypto-sha256-iterative;65;67;67;65;72;66;66;69;62;67 00:25:13 INFO - PID 3950 | __end_tp_report 00:25:13 INFO - PID 3950 | __start_cc_report 00:25:13 INFO - PID 3950 | _x_x_mozilla_cycle_collect,949 00:25:13 INFO - PID 3950 | __end_cc_report 00:25:13 INFO - PID 3950 | __startTimestamp1505373913076__endTimestamp 00:25:13 INFO - PID 3950 | 00:25:13 INFO - PID 3950 | ------- Summary: start ------- 00:25:13 INFO - PID 3950 | Number of tests: 14 00:25:13 INFO - PID 3950 | 00:25:13 INFO - PID 3950 | [#0] ai-astar Cycles:10 Average:109.10 Median:109.00 stddev:2.02 (1.9%) stddev-sans-first:2.03 00:25:13 INFO - PID 3950 | Values: 111.0 108.0 114.0 108.0 108.0 107.0 109.0 109.0 108.0 109.0 00:25:13 INFO - PID 3950 | 00:25:13 INFO - PID 3950 | [#1] audio-beat-detection Cycles:10 Average:123.80 Median:124.50 stddev:7.47 (6.0%) stddev-sans-first:7.88 00:25:13 INFO - PID 3950 | Values: 126.0 118.0 118.0 119.0 123.0 115.0 139.0 121.0 133.0 126.0 00:25:13 INFO - PID 3950 | 00:25:13 INFO - PID 3950 | [#2] audio-dft Cycles:10 Average:166.00 Median:166.00 stddev:3.43 (2.1%) stddev-sans-first:3.56 00:25:13 INFO - PID 3950 | Values: 164.0 163.0 163.0 167.0 163.0 169.0 174.0 166.0 166.0 165.0 00:25:13 INFO - PID 3950 | 00:25:13 INFO - PID 3950 | [#3] audio-fft Cycles:10 Average:77.80 Median:78.00 stddev:3.22 (4.1%) stddev-sans-first:3.32 00:25:13 INFO - PID 3950 | Values: 80.0 84.0 78.0 77.0 75.0 73.0 75.0 81.0 77.0 78.0 00:25:13 INFO - PID 3950 | 00:25:13 INFO - PID 3950 | [#4] audio-oscillator Cycles:10 Average:82.00 Median:82.00 stddev:2.94 (3.6%) stddev-sans-first:3.10 00:25:13 INFO - PID 3950 | Values: 81.0 88.0 80.0 78.0 81.0 82.0 82.0 82.0 86.0 80.0 00:25:13 INFO - PID 3950 | 00:25:13 INFO - PID 3950 | [#5] imaging-gaussian-blur Cycles:10 Average:114.20 Median:114.50 stddev:2.10 (1.8%) stddev-sans-first:2.22 00:25:13 INFO - PID 3950 | Values: 114.0 114.0 115.0 114.0 111.0 115.0 114.0 116.0 111.0 118.0 00:25:13 INFO - PID 3950 | 00:25:13 INFO - PID 3950 | [#6] imaging-darkroom Cycles:10 Average:149.90 Median:148.50 stddev:3.35 (2.3%) stddev-sans-first:3.48 00:25:13 INFO - PID 3950 | Values: 148.0 154.0 149.0 147.0 147.0 148.0 148.0 148.0 155.0 155.0 00:25:13 INFO - PID 3950 | 00:25:13 INFO - PID 3950 | [#7] imaging-desaturate Cycles:10 Average:96.30 Median:95.50 stddev:1.83 (1.9%) stddev-sans-first:1.88 00:25:13 INFO - PID 3950 | Values: 95.0 99.0 96.0 95.0 97.0 95.0 95.0 95.0 100.0 96.0 00:25:13 INFO - PID 3950 | 00:25:13 INFO - PID 3950 | [#8] json-parse-financial Cycles:10 Average:55.40 Median:54.50 stddev:4.99 (9.2%) stddev-sans-first:3.91 00:25:13 INFO - PID 3950 | Values: 65.0 58.0 52.0 54.0 55.0 51.0 52.0 52.0 63.0 52.0 00:25:13 INFO - PID 3950 | 00:25:13 INFO - PID 3950 | [#9] json-stringify-tinderbox Cycles:10 Average:44.30 Median:45.50 stddev:2.87 (6.3%) stddev-sans-first:2.92 00:25:13 INFO - PID 3950 | Values: 42.0 46.0 48.0 48.0 41.0 45.0 45.0 40.0 42.0 46.0 00:25:13 INFO - PID 3950 | 00:25:13 INFO - PID 3950 | [#10] stanford-crypto-aes Cycles:10 Average:77.70 Median:78.00 stddev:3.77 (4.8%) stddev-sans-first:3.67 00:25:13 INFO - PID 3950 | Values: 82.0 85.0 77.0 80.0 73.0 76.0 75.0 76.0 74.0 79.0 00:25:13 INFO - PID 3950 | 00:25:13 INFO - PID 3950 | [#11] stanford-crypto-ccm Cycles:10 Average:118.30 Median:119.50 stddev:3.43 (2.9%) stddev-sans-first:3.64 00:25:13 INFO - PID 3950 | Values: 118.0 120.0 110.0 122.0 117.0 119.0 117.0 120.0 122.0 118.0 00:25:13 INFO - PID 3950 | 00:25:13 INFO - PID 3950 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:169.60 Median:170.00 stddev:2.76 (1.6%) stddev-sans-first:2.12 00:25:13 INFO - PID 3950 | Values: 175.0 167.0 172.0 168.0 172.0 167.0 168.0 167.0 171.0 169.0 00:25:13 INFO - PID 3950 | 00:25:13 INFO - PID 3950 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.60 Median:67.00 stddev:2.63 (3.9%) stddev-sans-first:2.73 00:25:13 INFO - PID 3950 | Values: 65.0 67.0 67.0 65.0 72.0 66.0 66.0 69.0 62.0 67.0 00:25:13 INFO - PID 3950 | -------- Summary: end -------- 00:25:13 INFO - PID 3950 | 00:25:13 INFO - PID 3950 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 00:25:13 INFO - TEST-INFO | 3950: exit 0 00:25:14 INFO - TEST-OK | kraken | took 63036ms 00:25:14 INFO - SUITE-END | took 1177s 00:25:14 INFO - Completed test suite (00:19:37) 00:25:14 INFO - javascript benchmark 00:25:14 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8392.985845119143, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3099.6900309969, 3120.2043478912874, 3120.9375812483763, 3127.968720312797, 3132.3578666373396, 6017.127516510103, 6135.233095863017, 6142.877142457148, 6221.066839974006, 6266.62400255985, 6105.267367915856, 6164.506839452833, 6196.349383314755, 6210.2547694276755, 6238.157848690425, 5721.713914304279, 5726.45598668128, 5747.3677895431465, 5759.1937128802, 5794.0729483282685, 5685.204071430003, 5763.769449222026, 5767.394423585526, 5792.855178620526, 5803.448672376117, 5691.174779656947, 5723.656580605177, 5725.770969161229, 5751.712414379285, 5793.217915581385, 5742.196092547047, 5748.482636562709, 5764.048931926227, 5818.883622327529, 5841.85395365115, 5251.474852514756, 5513.669179849222, 5591.3569939456665, 5607.0, 5623.156526521055, 6082.756689732405, 6124.173236613089, 6243.87512249757, 6254.312025677172, 6255.468285195764, 6522.804315870531, 6554.934450655528, 6625.86748265032, 6632.8673426531195, 6718.0, 6677.465802735769, 6694.732210711566, 6719.899201511981, 6721.0926524919, 6735.12443382362, 6157.014877619604, 6171.691415429211, 6228.22147231596, 6249.375062493759, 6257.937420625781, 6806.591604503746, 6862.382385585322, 6867.107276054081, 6889.448844092561, 6914.412274956685, 6261.78083767066, 6390.552661313756, 6435.871282574322, 6580.506462015368, 6623.172103487064, 6620.337966203341, 6669.966650166718, 6687.465002799764, 6723.193216813916, 6753.8649227015185, 6597.274299827015, 6640.8671826563195, 6698.263191048981, 6719.361660642329, 6734.3602357775935, 6661.1007513985, 6661.600303981777, 6731.0, 6744.123263975652, 6749.797506074826, 5006.699598024057, 5080.237964305384, 5080.542751152414, 5086.872828179326, 5150.124478838607, 4472.530384309665, 4501.594856462934, 4508.233600287959, 4526.0, 4594.264917613166, 5616.69108199053, 5667.234923285304, 5702.657840529581, 5713.114467257582, 5728.283964504437, 6616.669166541654, 6619.371159739817, 6627.271000189975, 6637.1703537057865, 6651.16860392451, 5674.26234589509, 5686.630369026, 5697.487226149667, 5707.514861236758, 5718.914216286759, 5475.151351540518, 5592.217089607459, 5606.0, 5617.297837770278, 5632.633878797865, 6349.428551430301, 6413.615183089029, 6476.255230648441, 6503.2521260054755, 6532.150820393318, 6650.235222949423, 6653.434458071119, 6725.327467253235, 6727.596344219264, 6777.796666100025, 6280.497560195265, 6406.0, 6420.711068001858, 6440.8389790255615, 6455.419012288917, 6550.279469258473, 6570.47436205112, 6575.572587781779, 6588.242352129375, 6603.273639899703, 6608.9095299277005, 6747.932520674927, 6757.3242675732035, 6766.7969960901255, 6767.695453704693, 6443.323451037573, 6447.6453795041725, 6517.576357536745, 6526.608403495806, 6530.412262896362, 6313.810585682253, 6333.714982825692, 6354.364563543609, 6419.197600299963, 6471.0, 6343.207099112611, 6395.93604063972, 6413.935860641333, 6423.743050277936, 6427.325130861379, 6464.353564643498, 6500.902486462802, 6505.089287499848, 6590.176227971504, 6601.735930562723, 6136.815895523141, 6250.4374606285655, 6265.091561723616, 6275.623462592259, 6339.429451349401], "value": 6041.109275933566, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [795.6658203554507, 820.192110770891, 822.0382152881128, 822.5928165558049, 825.7605294464605, 38371.0, 41522.37716434256, 41852.79073604635, 41874.16251674968, 42152.36771448431, 38575.421368679425, 38645.227095458074, 38959.22081558367, 38984.61015389845, 39051.0, 6966.4078553323025, 7033.156021277454, 7073.328033836803, 7083.433325333961, 7560.054993125859, 7657.502262352929, 7776.961115194416, 7846.72536461224, 7847.411444141712, 7847.6860925562905, 7829.256220659028, 7842.215778422169, 7842.647080881374, 7852.921470785276, 7917.683292668286, 7739.6517156727805, 7782.610869456505, 7824.295813376766, 7832.686692532292, 7842.8431431371055, 7733.845323093563, 7772.300492955605, 7775.922240777633, 7796.72711455102, 7797.220277972157, 39086.0, 39268.80365598154, 39355.60644393548, 39395.60604393948, 39417.211655766725, 3542.4863394807867, 3574.2136729919375, 3575.106223444139, 3581.3732596795458, 3586.8206589670413, 30887.073387798402, 31160.065198044096, 31246.21884452884, 31327.216819579466, 31361.215969600715, 4995.925061124086, 5156.407013193493, 5203.9219411708855, 5327.121025030865, 5402.702851343174, 192931.0, 193263.0, 193356.0, 194425.0, 194595.02702486538, 42042.57957420448, 42812.35781463281, 48977.755111224214, 48994.51005489971, 49040.50959490431, 52091.73954130205, 53486.465135348924, 53768.731156343965, 53870.0, 53882.46117538775, 16497.422590209284, 16601.41895033668, 16644.167791610373, 16652.58368540772, 16676.16619169037, 13507.864921350661, 13511.527096551574, 13512.189268643913, 13515.662108447172, 13521.526746563823, 14222.857771422154, 14252.501162459264, 14262.857371426153, 14333.354999025069, 14402.279886005657, 5757.424257574209, 5796.710164491843, 5839.416058394127, 5847.152162936351, 5872.383399742966, 1010.1413798271558, 1014.6550172941236, 1020.3163880200284, 1030.90206430389, 1038.787048655024, 22838.771612283996, 23057.654135187986, 23165.7683423167, 23210.65184022241, 23365.41586460352, 1109.367660433545, 1117.5529788084832, 1124.128800179867, 1128.4639796096953, 1138.6299452677913, 12181.512739490321, 12227.510899563918, 12227.633171004883, 12288.0, 12323.383830808423, 224500.0, 225723.0, 226148.0, 227457.0, 228420.0, 52587.0, 52635.73682131565, 52711.472885270654, 52945.7352713234, 53045.204321935205, 1425.3701919957869, 1454.6872422429228, 1466.288849907794, 1472.2859413184597, 1480.0897448069359, 22350.0, 22600.321990340315, 22663.19735215565, 22934.19730309431, 23200.3039908803, 37172.256554869295, 37480.06299842417, 37572.060698482754, 37581.0, 37727.0, 194784.0, 196636.0, 197070.0, 198081.0, 198421.0, 31215.063548093593, 31519.527207091454, 34111.65888341085, 34466.0, 34653.48019779655, 42288.577114228465, 42546.57453425426, 42741.35887961745, 43501.56498435102, 43738.0, 30875.0, 31150.0, 31158.37683246277, 31521.52717709282, 31785.0, 30643.54034689526, 31052.22369440782, 31115.84442077775, 31277.84361078271, 31412.371752564362, 35366.29267414586, 35574.82212588921, 36123.916282510516, 36178.45732313965, 36232.63767362293, 29336.55995160117, 30648.0, 30669.23326916756, 30896.227594309425, 31412.685873140977, 22878.65682014738, 22995.754276905016, 23269.3019209424, 23811.523769524858, 23994.76005239995], "value": 17097.407813664107, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [533.1389805464177, 538.8949154914793, 545.8362491252626, 566.806459003656, 567.5980328588387, 21761.891190544044, 22496.8875155624, 22499.21252756154, 22523.887380563076, 22547.887260563693, 23653.172138975096, 24443.75556244437, 24757.38106547337, 24784.628230576556, 25395.238142855746, 6171.969140154293, 6235.781747638811, 6294.402031806971, 6318.052292156168, 6320.367963203666, 6285.088662143987, 6356.777512787054, 6380.489560835122, 6382.074599183115, 6388.968055159718, 6326.68366581669, 6344.587601805868, 6354.555181137299, 6360.204974378203, 6360.2367715873925, 6573.671316434207, 6580.80257592273, 6609.239937407187, 6611.107500487421, 6612.801615951529, 6097.664628445434, 6105.481034112106, 6130.1724267224245, 6134.662593557353, 6150.477209437203, 27955.58066629002, 28477.0, 28653.426931461254, 29310.560341594894, 29324.853375733197, 1994.351835653404, 2038.7553493580717, 2040.6224848403092, 2053.209514336976, 2056.321413933398, 19571.21715131393, 19841.404757857286, 19923.10346034432, 19939.401817945483, 20006.299779507648, 2424.2000139953775, 2459.655648209252, 2505.736897625741, 2509.6737424134926, 2517.320323512641, 112522.0, 118706.0, 136471.0, 138362.3081884584, 144716.0, 14552.345144468525, 14589.756192008042, 14712.926435367755, 14737.852621473863, 15001.774973375408, 22085.779142208692, 22105.557888842133, 22251.666225006637, 22403.887980559994, 22435.439114021952, 10129.898701013042, 10245.436500992368, 10251.538680759235, 10319.535620897077, 10488.475576221159, 9725.367851089657, 9768.853467197856, 9818.607255709692, 9823.214142868554, 9930.751731206634, 8859.64561417549, 9110.633404989305, 9131.954340228256, 9235.12266334697, 9264.67573634933, 2691.9596206056926, 2764.087851009162, 2768.404792969521, 2771.3348796288747, 2866.971330286712, 944.7779771753633, 972.7130496503548, 980.7989362180735, 985.0445068283753, 995.4922989275377, 19262.17009384106, 19327.226910923688, 19339.709904351446, 19461.12424940881, 19707.507312317306, 1045.7072019834307, 1048.7745134796055, 1052.2634156090767, 1054.2462139570243, 1055.5672174408455, 10750.301230419998, 10775.245732798629, 10835.51240194193, 10992.626714326232, 11226.101911847032, 451753.0, 452666.0, 464782.0, 470504.0, 473793.0, 111614.0, 112646.0, 112954.43522782334, 113640.43179784213, 114336.42831785788, 1168.9240199387013, 1181.2912252648514, 1235.1473530792296, 1248.8001919692806, 1253.7241806802672, 20792.37622871316, 20980.58038839184, 21372.57254854863, 21386.465338366666, 21450.141994320053, 54864.17703734527, 55148.72425637846, 55201.171982421096, 56049.0, 56502.71748641231, 67063.66468167628, 67723.0, 68281.31718682949, 68287.65856170886, 69303.65348173227, 14113.2237726926, 14261.857381426053, 14286.357113929691, 14363.281835908372, 14402.0, 22873.771262287828, 22923.541529169655, 22982.770172298733, 23204.3038708839, 23301.883490582437, 18207.180676869837, 18334.724979125058, 18553.2578696856, 18586.0, 18727.157277922255, 16606.50180494587, 16829.74755378646, 16948.661026779642, 17046.82953170502, 17094.145292735564, 17904.820951790316, 18380.356687515872, 18595.34916277924, 18762.624747505248, 18816.153273103017, 13952.58142255734, 14176.645583860485, 14225.430982760574, 14229.217393043067, 14349.497767578503, 17850.821491784915, 18052.458426247234, 18520.0, 18675.06624668734, 18680.25278988825], "value": 11908.692037994608, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1299.0, 1352.1549031855097, 1356.681179922718, 1360.16349944784, 1360.9523666671669, 14925.0, 15467.845321546782, 15526.146061966587, 15586.220688965563, 15623.062616243033, 15115.39538418462, 15152.545423637308, 15295.541133766004, 15397.153156576383, 15461.22693865305, 2554.846709197454, 2565.551028570002, 2591.7926565874686, 2602.349412646838, 2605.2054123492326, 2530.860802655853, 2542.1229675761833, 2587.4695687384137, 2592.3648706066947, 2598.0387256715044, 2623.868806559674, 2768.792340574455, 2769.2246171072034, 2801.1876555798895, 2804.242854429303, 2772.88908443662, 2774.1954833098375, 2811.283122803682, 2814.549672052482, 2815.591739197815, 2579.548578998668, 2718.510668079765, 2730.2082396105106, 2741.4517096580566, 2756.0629386008654, 15242.923785381114, 15349.616259593487, 15365.539033829004, 15367.15480648564, 15381.307841147063, 7975.920240797575, 8135.023797144321, 8195.221453961924, 8195.303399211074, 8198.0, 5106.131957567222, 5245.396779370345, 5306.814261500867, 5348.866278343073, 5355.892882142335, 1810.1582764014665, 1815.8365747082826, 1843.1982087791853, 1876.1088482970615, 1879.6146789908037, 25975.74024259752, 26104.8694756525, 26224.475510489683, 26240.60639090415, 26276.86861565699, 6612.669366531654, 6690.732370705215, 6752.831179220559, 6916.4092258780765, 6919.930800692029, 16982.490525284262, 16996.915015424845, 17040.233189506504, 17070.317187312616, 17196.22616982239, 7775.49459285156, 7857.1357150713375, 7869.881951770728, 7941.0, 7970.163132871081, 6985.0, 7189.532680375759, 7192.676329565182, 7348.412127029825, 7376.0411146550605, 5116.923246151311, 5321.787128514893, 5337.466253374709, 5339.786408543615, 5586.217929489874, 1549.6978089272484, 1562.312582463735, 1563.265265325318, 1563.7498000320122, 1565.0687840734745, 841.1504380575662, 845.4800297816921, 863.6674880171054, 867.2324992381662, 870.8084221471266, 6812.0, 6821.556598821061, 6874.037634731141, 7929.207079292025, 8130.471519351223, 699.9790006299819, 708.2492557888654, 716.2694052066863, 720.3660778514978, 721.4192574977089, 4716.834910778106, 4949.232868905326, 5043.5460808527405, 5050.217216331474, 5115.462876397999, 20461.89769051175, 20859.478513037295, 21654.675179872316, 21714.891425543086, 21737.67393489099, 20858.165673373198, 21350.78649213519, 21392.679109813365, 21406.785932140792, 21409.571808564055, 9371.578278977326, 9945.055219754111, 10090.646827361006, 10100.747481313027, 10116.291859569907, 7890.289873911375, 7898.921010789819, 7907.2488113629115, 7986.880196796937, 7997.280244777998, 17788.46634600964, 18234.635307293516, 18493.72259416137, 18689.719654204924, 18751.624967500848, 18712.25150993945, 18980.715289270396, 19101.808981910002, 19157.329493467663, 19260.614787704446, 10587.576496940035, 10838.187135964676, 10876.945615271872, 10955.233133680566, 11029.503672334604, 13563.86436135626, 13768.862311376757, 13772.65568360799, 13774.311284435538, 13779.586612401645, 10576.894231057591, 10693.732656683645, 10801.243912926335, 10912.181586380895, 10985.066269367193, 10010.299279050396, 10284.074433301039, 10349.344104943173, 10550.947245263724, 10589.894101058891, 9189.0, 9284.767880803034, 9421.434713917188, 9488.667896623585, 9493.525323733647, 6771.898421523582, 6915.930840691529, 6950.443964482931, 6983.790486285419, 7001.054857594363, 6670.0, 6719.428848547928, 6723.596584204964, 6733.528652994243, 6773.322667733188], "value": 6469.601783339301, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [465.13717054863247, 468.4519112638213, 491.40539946664535, 510.9182530795072, 515.6648178683855, 6141.72362243699, 6185.9999999999945, 6243.282022567406, 6268.65522396268, 6306.495480361572, 6137.355577664348, 6157.322694503601, 6164.229471316085, 6184.257889053309, 6201.906971395421, 5085.211792172219, 5097.770600322985, 5122.718250496221, 5129.615278854082, 5132.0, 4995.125852975733, 5041.218611115265, 5070.873228169288, 5096.949030509703, 5104.208847628605, 4698.765061746916, 4811.4707382187935, 4908.779104940269, 4919.360483137187, 4934.333864928225, 4821.710697358169, 4854.393200849894, 4856.465788763233, 4894.608431325485, 4925.975370123145, 4339.153864996327, 4363.36731173978, 4387.617900361376, 4396.230659634583, 4412.6690498212765, 5852.0, 5988.610740301867, 5990.161377407167, 6054.848628784272, 6058.909116363258, 5555.666660000373, 5586.078297080977, 5587.692676902769, 5608.10270356741, 5626.240457538262, 6434.871302573969, 6437.130987316699, 6455.9354406455805, 6467.383154211447, 6483.286838447767, 4570.925832429376, 4785.95214047862, 4791.544803243686, 4800.0879832832, 4834.0, 6544.541882068257, 6622.377517508193, 6632.502562307846, 6774.898376524356, 6789.422899053537, 4891.951080489221, 4892.804287828447, 4895.069936712013, 4906.730129842822, 4929.75351232437, 4921.7785199666105, 4984.700917944935, 4999.375078115236, 5007.87008119925, 5038.773255203525, 5541.254504830966, 5568.853597717277, 5612.130119831432, 5622.718864056781, 5627.409122042209, 6491.344707099754, 6518.804435866931, 6520.282768895418, 6529.8694026120165, 6550.246721627074, 1707.6072503324306, 1711.4266720648473, 1732.6534693061185, 1735.158448152645, 1752.229019231534, 1132.1735133352533, 1195.491915935724, 1213.7875871722413, 1214.2532342609409, 1229.7479016801535, 5517.475839795213, 5589.357223919302, 5616.550675945915, 5644.814588936288, 5682.215714299963, 6505.902411463831, 6512.869742605121, 6544.247411547638, 6553.770618028441, 6608.504362172856, 5602.747876345574, 5609.960828203687, 5659.236003139606, 5662.725886675547, 5698.6580805151825, 3470.7396945229207, 3478.756487045933, 3504.6857428464327, 3531.346700860349, 3537.1864471171775, 6305.369463053658, 6347.460465860361, 6399.9040014399825, 6411.743530258737, 6419.967900160469, 6672.766453174116, 6701.5308928375525, 6773.9322606774285, 6778.7288508459105, 6809.829754256084, 6285.654289014148, 6297.307296197415, 6352.474376720964, 6394.424501794861, 6403.551751377452, 5922.822315330547, 6334.194754494947, 6363.391009686006, 6504.447121994684, 6529.67351632426, 6332.810015699536, 6359.427651511386, 6359.87280254383, 6378.617282963037, 6499.902501462388, 6133.466633341664, 6200.689965501617, 6215.223097112861, 6238.344973777688, 6315.463185629273, 4845.200541910545, 4854.320395144612, 4869.172240719157, 4893.192623217129, 4918.778654960463, 6282.937170628235, 6370.362963703593, 6552.3775241352, 6557.409833115043, 6676.365745254193, 6356.396142366468, 6366.427021568081, 6386.9680651596445, 6477.902831457438, 6515.413612774873, 6295.527835412271, 6347.968260158855, 6355.3326900674765, 6392.232932048184, 6423.454006409321, 6153.077038444269, 6318.715657795502, 6337.7781777637565, 6363.745450181941, 6366.981282994699, 6404.807855764335, 6476.158099447231, 6482.384173503509, 6506.284308725942, 6520.598071414669, 6225.252969643671, 6231.9688401557705, 6253.96873015632, 6299.811005669837, 6322.652254126067], "value": 4956.098323310992, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [835.4444294544129, 851.4252879306468, 889.7508697564684, 899.6131663384746, 926.6849271247775, 19086.522836929067, 19791.307304244354, 19964.70052949207, 19993.10031048601, 20020.79875207487, 18156.18297176627, 18619.255229790793, 18806.90596547019, 19225.519362015955, 19300.0, 964.3201542912248, 974.0843607009424, 977.4184360305607, 977.9511024448784, 979.4172467381896, 966.1160038564705, 980.4999450280337, 981.293468702533, 981.411153308013, 982.5873133284038, 999.1207737191298, 1021.1983592879591, 1025.646152077532, 1025.784585237101, 1026.271347343387, 1023.483141013787, 1023.918086553074, 1024.2164743970905, 1025.6974192613197, 1026.7330494071557, 720.6576875983918, 748.2629609834308, 751.0161688188491, 751.8721817291074, 754.5133388964142, 19963.401097967086, 20230.190792368434, 20241.392758217276, 20369.8981505093, 20464.0, 21501.247456339108, 21586.676199857015, 22280.554388912293, 22358.55282894333, 22508.549829003492, 17523.824761752476, 17544.91227543867, 17717.911410442994, 17813.46559603214, 17886.016269105196, 3679.4848721178787, 3717.5353080864893, 3730.2725968436166, 3754.1928485375774, 3763.435484677293, 137405.0, 138304.30847845797, 140939.29530352386, 141192.0, 143116.2844185783, 16791.832081679273, 17012.0, 17152.456278934955, 17268.99999999975, 17388.391406300718, 30860.84569577138, 31630.367392652017, 31809.0, 32003.51994720081, 32096.518552221736, 7940.801479962932, 7966.283034526805, 7987.0, 8006.1993800619475, 8024.197580242046, 4061.2080644274083, 4103.610157035077, 4106.630403263661, 4181.790910454526, 4186.518550366686, 5419.512243898068, 5589.273394458775, 5600.439956004367, 5622.746976386073, 5625.578081643893, 939.534930209537, 958.2765012415582, 968.4479846487575, 972.0571046085286, 977.237754551451, 691.1395312835552, 705.8694141583824, 715.3025799845213, 715.9046658612332, 725.365305357812, 11227.775444491064, 11289.0, 11667.766644667228, 11848.70378240551, 12106.515739370503, 664.1532046640475, 671.9798406047827, 672.9495287853431, 682.7507959594712, 688.9183981149647, 5253.789848406097, 5295.205719142159, 5305.257263983045, 5312.73436328182, 5482.80810171642, 122889.0, 123009.0, 124961.37519312528, 127402.0, 127696.0, 107346.46326768317, 109691.45154274337, 110420.44789776161, 112727.43636281767, 113294.43352783348, 88656.55671721729, 89634.10365896388, 92081.07918920858, 92108.0, 92456.0, 9674.129328360481, 9725.610975561181, 9743.707688769347, 9804.068613481708, 9825.017498250403, 43171.78414107909, 44282.3357649629, 44365.556344437435, 44812.77593612011, 45265.32102018406, 54279.18581221364, 54331.45668543264, 55050.724746377615, 55103.724481377336, 56609.433905660415, 15784.21078946071, 16001.599960001093, 16077.75883361727, 16142.0, 16165.59586010359, 17089.060101694526, 17145.571360716083, 17252.22364993553, 17424.303027878745, 17494.825051749318, 15997.360105595646, 16010.439634612732, 16047.679046418772, 16105.516834494983, 16144.596385090466, 15571.610709731895, 15935.840641593899, 15981.0, 16003.519894403187, 16131.354745810506, 14803.407863685332, 14807.185604791839, 14888.25558722038, 14979.475718349806, 15089.170095644846, 11756.94121529387, 11849.466773995364, 11937.164398492023, 12162.087843411602, 12224.266544007389, 11503.079753619522, 11625.18623696333, 11722.120840937134, 11726.824097638371, 12018.879811201776], "value": 8862.237982900147, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1450.9999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 108.0, 114.0, 108.0, 108.0, 107.0, 109.0, 109.0, 108.0, 109.0], "value": 109.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [126.0, 118.0, 118.0, 119.0, 123.0, 115.0, 139.0, 121.0, 133.0, 126.0], "value": 123.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 163.0, 163.0, 167.0, 163.0, 169.0, 174.0, 166.0, 166.0, 165.0], "value": 166.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 84.0, 78.0, 77.0, 75.0, 73.0, 75.0, 81.0, 77.0, 78.0], "value": 77.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 88.0, 80.0, 78.0, 81.0, 82.0, 82.0, 82.0, 86.0, 80.0], "value": 82.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 115.0, 114.0, 111.0, 115.0, 114.0, 116.0, 111.0, 118.0], "value": 114.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 154.0, 149.0, 147.0, 147.0, 148.0, 148.0, 148.0, 155.0, 155.0], "value": 149.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 99.0, 96.0, 95.0, 97.0, 95.0, 95.0, 95.0, 100.0, 96.0], "value": 96.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 58.0, 52.0, 54.0, 55.0, 51.0, 52.0, 52.0, 63.0, 52.0], "value": 55.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [42.0, 46.0, 48.0, 48.0, 41.0, 45.0, 45.0, 40.0, 42.0, 46.0], "value": 44.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 85.0, 77.0, 80.0, 73.0, 76.0, 75.0, 76.0, 74.0, 79.0], "value": 77.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 120.0, 110.0, 122.0, 117.0, 119.0, 117.0, 120.0, 122.0, 118.0], "value": 118.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [175.0, 167.0, 172.0, 168.0, 172.0, 167.0, 168.0, 167.0, 171.0, 169.0], "value": 169.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 67.0, 67.0, 65.0, 72.0, 66.0, 66.0, 69.0, 62.0, 67.0], "value": 66.6, "unit": "score"}]}]} 00:25:14 INFO - Return code: 0 00:25:14 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 00:25:14 INFO - # TBPL SUCCESS # 00:25:14 INFO - Running post-action listener: _package_coverage_data 00:25:14 INFO - Running post-action listener: _resource_record_post_action 00:25:14 INFO - [mozharness: 2017-09-14 07:25:14.377247Z] Finished run-tests step (success) 00:25:14 INFO - Running post-run listener: _resource_record_post_run 00:25:14 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 10502144; Write bytes: 335892480; Read time: 6784; Write time: 213948 00:25:14 INFO - TinderboxPrint: CPU usage
13.3% 00:25:14 INFO - TinderboxPrint: I/O read bytes / time
10,502,144 / 6,784 00:25:14 INFO - TinderboxPrint: I/O write bytes / time
335,892,480 / 213,948 00:25:14 INFO - TinderboxPrint: CPU idle
8,265.6 (86.7%) 00:25:14 INFO - TinderboxPrint: CPU user
1,202.4 (12.6%) 00:25:14 INFO - TinderboxPrint: Swap in / out
0 / 0 00:25:14 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 12992512; Read time: 0; Write time: 3968 00:25:14 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 00:25:14 INFO - run-tests - Wall time: 1178s; CPU: 13.0%; Read bytes: 10498048; Write bytes: 322510848; Read time: 6772; Write time: 209956 00:25:15 INFO - Running post-run listener: _upload_blobber_files 00:25:15 INFO - Blob upload gear active. 00:25:15 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 00:25:15 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 00:25:15 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'] 00:25:15 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 00:25:15 INFO - (blobuploader) - INFO - Open directory for files ... 00:25:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 00:25:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:25:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:25:22 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 00:25:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:25:22 INFO - (blobuploader) - INFO - Done attempting. 00:25:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 00:25:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:25:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:25:23 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 00:25:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:25:23 INFO - (blobuploader) - INFO - Done attempting. 00:25:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 00:25:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:25:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:25:24 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 00:25:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:25:24 INFO - (blobuploader) - INFO - Done attempting. 00:25:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 00:25:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:25:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:25:25 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 00:25:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:25:25 INFO - (blobuploader) - INFO - Done attempting. 00:25:25 INFO - (blobuploader) - INFO - Iteration through files over. 00:25:25 INFO - Return code: 0 00:25:25 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 00:25:25 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 00:25:25 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/130d2bb5d89839db440bf242ef44ab6280c34067200bc9ef011535466505ae079a7315f2cd3edbb1d20522bd3d85e5e46551c5a909bf17df5af89540f30d36c6", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/98319ae1272e6d43198d143e87e6b1dfe51ce2360fb69db458ed27c28364a3ebfffe97d053776b7efc5bc57e34bd0990f3d916cf2f9fba119af3de3012000cfa", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f3eaabb438a4aef876e39ea6f3d167c888cb4116ec87c76f10c3f9ee94c1391754b52fcf3f1f7c37b7ca7788ab92cfc554e80c2e6d8a7f6738d2c8a627314afe", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/11e11a3c47ec6c9f3f24061b8dce317d2ad80f9fe14a86df225c2bb0f339d8df8490e4551e761f5442f674f3761376f091668c0ca34fdba203daaac74eb73552"} 00:25:25 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 00:25:25 INFO - Writing to file /builds/slave/test/properties/blobber_files 00:25:25 INFO - Contents: 00:25:25 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/130d2bb5d89839db440bf242ef44ab6280c34067200bc9ef011535466505ae079a7315f2cd3edbb1d20522bd3d85e5e46551c5a909bf17df5af89540f30d36c6", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/98319ae1272e6d43198d143e87e6b1dfe51ce2360fb69db458ed27c28364a3ebfffe97d053776b7efc5bc57e34bd0990f3d916cf2f9fba119af3de3012000cfa", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f3eaabb438a4aef876e39ea6f3d167c888cb4116ec87c76f10c3f9ee94c1391754b52fcf3f1f7c37b7ca7788ab92cfc554e80c2e6d8a7f6738d2c8a627314afe", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/11e11a3c47ec6c9f3f24061b8dce317d2ad80f9fe14a86df225c2bb0f339d8df8490e4551e761f5442f674f3761376f091668c0ca34fdba203daaac74eb73552"} 00:25:25 INFO - Running post-run listener: copy_logs_to_upload_dir 00:25:25 INFO - Copying logs to upload dir... 00:25:25 INFO - mkdir: /builds/slave/test/build/upload/logs 00:25:25 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1246.880366 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2017-09-14 00:25:25.604977) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-14 00:25:25.608990) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=51fc86400edbde9650d2781a000001d0-1505370572.267818-213713610 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/130d2bb5d89839db440bf242ef44ab6280c34067200bc9ef011535466505ae079a7315f2cd3edbb1d20522bd3d85e5e46551c5a909bf17df5af89540f30d36c6", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/98319ae1272e6d43198d143e87e6b1dfe51ce2360fb69db458ed27c28364a3ebfffe97d053776b7efc5bc57e34bd0990f3d916cf2f9fba119af3de3012000cfa", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f3eaabb438a4aef876e39ea6f3d167c888cb4116ec87c76f10c3f9ee94c1391754b52fcf3f1f7c37b7ca7788ab92cfc554e80c2e6d8a7f6738d2c8a627314afe", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/11e11a3c47ec6c9f3f24061b8dce317d2ad80f9fe14a86df225c2bb0f339d8df8490e4551e761f5442f674f3761376f091668c0ca34fdba203daaac74eb73552"} build_url:https://queue.taskcluster.net/v1/task/XsUnDtePTKytTQbE-xS2cw/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011340 build_url: 'https://queue.taskcluster.net/v1/task/XsUnDtePTKytTQbE-xS2cw/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/130d2bb5d89839db440bf242ef44ab6280c34067200bc9ef011535466505ae079a7315f2cd3edbb1d20522bd3d85e5e46551c5a909bf17df5af89540f30d36c6", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/98319ae1272e6d43198d143e87e6b1dfe51ce2360fb69db458ed27c28364a3ebfffe97d053776b7efc5bc57e34bd0990f3d916cf2f9fba119af3de3012000cfa", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f3eaabb438a4aef876e39ea6f3d167c888cb4116ec87c76f10c3f9ee94c1391754b52fcf3f1f7c37b7ca7788ab92cfc554e80c2e6d8a7f6738d2c8a627314afe", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/11e11a3c47ec6c9f3f24061b8dce317d2ad80f9fe14a86df225c2bb0f339d8df8490e4551e761f5442f674f3761376f091668c0ca34fdba203daaac74eb73552"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-14 00:25:25.639663) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-14 00:25:25.639992) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=51fc86400edbde9650d2781a000001d0-1505370572.267818-213713610 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004571 ========= master_lag: 0.07 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-14 00:25:25.719474) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-14 00:25:25.721708) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-14 00:25:25.722012) ========= ========= Total master_lag: 0.21 =========