builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-018 starttime: 1505372666.2 results: success (0) revision: 9517eea4a1a5955618fc79d039f9f0282b7185ca ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-14 00:04:26.197724) ========= 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.198090) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-14 00:04:26.198352) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-14 00:04:26.400611) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-14 00:04:26.400870) ========= 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=62c568580acbfdaac3eec7be000001dc-1505372454.848864-649808837 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% 50.4M=0s 2017-09-14 00:04:26 (50.4 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.159998 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-14 00:04:26.586387) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-14 00:04:26.586690) ========= 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=62c568580acbfdaac3eec7be000001dc-1505372454.848864-649808837 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015308 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-14 00:04:26.645083) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 11 secs) (at 2017-09-14 00:04:26.645367) ========= 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=62c568580acbfdaac3eec7be000001dc-1505372454.848864-649808837 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-14 00:04:26,672 truncating revision to first 12 chars 2017-09-14 00:04:26,672 Setting DEBUG logging. 2017-09-14 00:04:26,672 attempt 1/10 2017-09-14 00:04:26,672 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:27,391 attempt 1/10 2017-09-14 00:04:28,544 current task status: no status available at this point. state: STARTED 2017-09-14 00:04:28,545 sleeping for 9.00s (attempt 1/10) 2017-09-14 00:04:37,554 attempt 2/10 2017-09-14 00:04:37,887 current task status: Task completed! Check 's3_urls' for upload locations. state: SUCCESS 2017-09-14 00:04:38,068 unpacking tar archive at: mozilla-central-9517eea4a1a5/testing/mozharness/ program finished with exit code 0 elapsedTime=11.700592 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 11 secs) (at 2017-09-14 00:04:38.363705) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-14 00:04:38.363982) ========= script_repo_revision: 9517eea4a1a5955618fc79d039f9f0282b7185ca ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-14 00:04:38.364311) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-14 00:04:38.364561) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-14 00:04:38.381847) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2017-09-14 00:04:38.382117) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=62c568580acbfdaac3eec7be000001dc-1505372454.848864-649808837 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-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 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-Non-PGO', 00:04:38 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 00:04:38 INFO - 'branch': 'Firefox-Non-PGO', 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-018', 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.546492Z] 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:39 INFO - Running post-action listener: _resource_record_post_action 00:04:39 INFO - [mozharness: 2017-09-14 07:04:39.531046Z] Finished clobber step (success) 00:04:39 INFO - [mozharness: 2017-09-14 07:04:39.531143Z] Running read-buildbot-config step. 00:04:39 INFO - Running pre-action listener: _resource_record_pre_action 00:04:39 INFO - Running main action method: read_buildbot_config 00:04:39 INFO - Using buildbot properties: 00:04:39 INFO - { 00:04:39 INFO - "project": "", 00:04:39 INFO - "product": "firefox", 00:04:39 INFO - "who": "kwierso@gmail.com", 00:04:39 INFO - "installer_path": "public/build/target.tar.bz2", 00:04:39 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 00:04:39 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 00:04:39 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 00:04:39 INFO - "stage_platform": "linux64", 00:04:39 INFO - "basedir": "/builds/slave/test", 00:04:39 INFO - "buildnumber": 822, 00:04:39 INFO - "platform": "ubuntu64_hw", 00:04:39 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 00:04:39 INFO - "slavebuilddir": "test", 00:04:39 INFO - "taskId": "UNcOszHaSYu4-AREQPzClw", 00:04:39 INFO - "branch": "mozilla-central", 00:04:39 INFO - "script_repo_revision": "production", 00:04:39 INFO - "revision": "9517eea4a1a5955618fc79d039f9f0282b7185ca", 00:04:39 INFO - "slavename": "talos-linux64-ix-018", 00:04:39 INFO - "repo_path": "mozilla-central" 00:04:39 INFO - } 00:04:39 INFO - Finding installer, test and symbols from parent task. 00:04:39 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/UNcOszHaSYu4-AREQPzClw'}, attempt #1 00:04:40 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/UNcOszHaSYu4-AREQPzClw'}, attempt #1 00:04:40 INFO - Task dependencies: XsUnDtePTKytTQbE-xS2cw 00:04:40 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.013851Z] Finished read-buildbot-config step (success) 00:04:41 INFO - [mozharness: 2017-09-14 07:04:41.014073Z] 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:41 INFO - Downloaded 989 bytes. 00:04:41 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 00:04:41 INFO - Using the following test package requirements: 00:04:41 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 00:04:41 INFO - u'common': [u'target.common.tests.zip'], 00:04:41 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 00:04:41 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 00:04:41 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 00:04:41 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 00:04:41 INFO - u'mozbase': [u'target.common.tests.zip'], 00:04:41 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 00:04:41 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 00:04:41 INFO - u'web-platform': [u'target.common.tests.zip', 00:04:41 INFO - u'target.web-platform.tests.tar.gz'], 00:04:41 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 00:04:41 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 00:04:41 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:41 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:41 INFO - Fetch https://queue.taskcluster.net/v1/task/XsUnDtePTKytTQbE-xS2cw/artifacts/public/build/target.common.tests.zip into memory 00:04:42 INFO - Content-Length response header: 54588754 00:04:42 INFO - Bytes received: 54588754 00:04:53 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:53 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:53 INFO - Fetch https://queue.taskcluster.net/v1/task/XsUnDtePTKytTQbE-xS2cw/artifacts/public/build/target.talos.tests.zip into memory 00:04:54 INFO - Content-Length response header: 14500356 00:04:54 INFO - Bytes received: 14500356 00:04:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:04:54 INFO - trying https://queue.taskcluster.net/v1/task/XsUnDtePTKytTQbE-xS2cw/artifacts/public/build/target.tar.bz2 00:04:54 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:54 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:56 INFO - Downloaded 61234552 bytes. 00:04:56 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/XsUnDtePTKytTQbE-xS2cw/artifacts/public/build/target.tar.bz2 00:04:56 INFO - mkdir: /builds/slave/test/properties 00:04:56 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 00:04:56 INFO - Writing to file /builds/slave/test/properties/build_url 00:04:56 INFO - Contents: 00:04:56 INFO - build_url:https://queue.taskcluster.net/v1/task/XsUnDtePTKytTQbE-xS2cw/artifacts/public/build/target.tar.bz2 00:04:56 INFO - Running post-action listener: _resource_record_post_action 00:04:56 INFO - Running post-action listener: find_tests_for_verification 00:04:56 INFO - Running post-action listener: set_extra_try_arguments 00:04:56 INFO - [mozharness: 2017-09-14 07:04:56.570247Z] Finished download-and-extract step (success) 00:04:56 INFO - [mozharness: 2017-09-14 07:04:56.570348Z] Running populate-webroot step. 00:04:56 INFO - Running pre-action listener: _resource_record_pre_action 00:04:56 INFO - Running main action method: populate_webroot 00:04:56 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 00:04:56 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 00:04:56 INFO - 'tests': ['tresize', 00:04:56 INFO - 'tcanvasmark']}, 00:04:56 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 00:04:56 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 00:04:56 INFO - 'tests': ['dromaeo_css', 00:04:56 INFO - 'kraken']}, 00:04:56 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 00:04:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:04:56 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 00:04:56 INFO - 'talos_options': ['--disable-stylo'], 00:04:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:04:56 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 00:04:56 INFO - 'tests': ['damp', 'tps']}, 00:04:56 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 00:04:56 INFO - 'talos_options': ['--disable-stylo'], 00:04:56 INFO - 'tests': ['damp', 'tps']}, 00:04:56 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 00:04:56 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 00:04:56 INFO - 'tests': ['dromaeo_dom']}, 00:04:56 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 00:04:56 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 00:04:56 INFO - 'tests': ['basic_compositor_video', 00:04:56 INFO - 'glvideo']}, 00:04:56 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 00:04:56 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 00:04:56 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 00:04:56 INFO - 'talos_options': ['--disable-stylo'], 00:04:56 INFO - 'tests': ['ts_paint_webext', 00:04:56 INFO - 'tp5o_webext']}, 00:04:56 INFO - 'other-e10s': {'tests': ['a11yr', 00:04:56 INFO - 'ts_paint', 00:04:56 INFO - 'tpaint', 00:04:56 INFO - 'sessionrestore', 00:04:56 INFO - 'sessionrestore_many_windows', 00:04:56 INFO - 'sessionrestore_no_auto_restore', 00:04:56 INFO - 'tabpaint']}, 00:04:56 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 00:04:56 INFO - 'tests': ['a11yr', 00:04:56 INFO - 'ts_paint', 00:04:56 INFO - 'tpaint', 00:04:56 INFO - 'sessionrestore', 00:04:56 INFO - 'sessionrestore_many_windows', 00:04:56 INFO - 'sessionrestore_no_auto_restore', 00:04:56 INFO - 'tabpaint']}, 00:04:56 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 00:04:56 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 00:04:56 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 00:04:56 INFO - 'tests': ['bloom_basic_singleton']}, 00:04:56 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 00:04:56 INFO - 'tests': ['bloom_basic']}, 00:04:56 INFO - 'svgr-e10s': {'tests': ['tsvgx', 00:04:56 INFO - 'tsvgr_opacity', 00:04:56 INFO - 'tart', 00:04:56 INFO - 'tscrollx', 00:04:56 INFO - 'tsvg_static']}, 00:04:56 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 00:04:56 INFO - 'tests': ['tsvgx', 00:04:56 INFO - 'tsvgr_opacity', 00:04:56 INFO - 'tart', 00:04:56 INFO - 'tscrollx', 00:04:56 INFO - 'tsvg_static']}, 00:04:56 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 00:04:56 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 00:04:56 INFO - 'talos_options': ['--disable-stylo'], 00:04:56 INFO - 'tests': ['tp5o']}, 00:04:56 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 00:04:56 INFO - 'talos_options': ['--mitmproxy', 00:04:56 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 00:04:56 INFO - '--firstNonBlankPaint'], 00:04:56 INFO - 'tests': ['tp6_google', 00:04:56 INFO - 'tp6_youtube', 00:04:56 INFO - 'tp6_amazon', 00:04:56 INFO - 'tp6_facebook']}, 00:04:56 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 00:04:56 INFO - 'talos_options': ['--disable-stylo', 00:04:56 INFO - '--mitmproxy', 00:04:56 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 00:04:56 INFO - '--firstNonBlankPaint'], 00:04:56 INFO - 'tests': ['tp6_google', 00:04:56 INFO - 'tp6_youtube', 00:04:56 INFO - 'tp6_amazon', 00:04:56 INFO - 'tp6_facebook']}, 00:04:56 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 00:04:56 INFO - 'talos_options': ['--stylo-threads=1', 00:04:56 INFO - '--mitmproxy', 00:04:56 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 00:04:56 INFO - '--firstNonBlankPaint'], 00:04:56 INFO - 'tests': ['tp6_google', 00:04:56 INFO - 'tp6_youtube', 00:04:56 INFO - 'tp6_amazon', 00:04:56 INFO - 'tp6_facebook']}, 00:04:56 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 00:04:56 INFO - 'talos_options': ['--xperf_path', 00:04:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:04:56 INFO - 'tests': ['tp5n']}, 00:04:56 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 00:04:56 INFO - 'talos_options': ['--disable-stylo', 00:04:56 INFO - '--xperf_path', 00:04:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:04:56 INFO - 'tests': ['tp5n']}}} 00:04:56 INFO - Running post-action listener: _resource_record_post_action 00:04:56 INFO - [mozharness: 2017-09-14 07:04:56.585368Z] Finished populate-webroot step (success) 00:04:56 INFO - [mozharness: 2017-09-14 07:04:56.585467Z] Running create-virtualenv step. 00:04:56 INFO - Running pre-action listener: _resource_record_pre_action 00:04:56 INFO - Running main action method: create_virtualenv 00:04:56 INFO - Creating virtualenv /builds/slave/test/build/venv 00:04:56 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 00:04:56 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 00:04:56 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 00:04:56 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 00:04:56 INFO - New python executable in /builds/slave/test/build/venv/bin/python 00:04:57 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 0x20601f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2229a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23cca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23d0090>, '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 0x23d0d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23caf90>, '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': '62c568580acbfdaac3eec7be000001dc-1505372454.848864-649808837', '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': '62c568580acbfdaac3eec7be000001dc-1505372454.848864-649808837', 00:04:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:04:58 INFO - '_': '/tools/buildbot/bin/python'} 00:04:59 INFO - Ignoring indexes: http://pypi.python.org/simple/ 00:04:59 INFO - Downloading/unpacking pip>=1.5 00:04:59 INFO - Running setup.py egg_info for package pip 00:04:59 INFO - warning: no files found matching 'pip/cacert.pem' 00:04:59 INFO - warning: no files found matching '*.html' under directory 'docs' 00:04:59 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 00:04:59 INFO - no previously-included directories found matching 'docs/_build/_sources' 00:04:59 INFO - Installing collected packages: pip 00:04:59 INFO - Found existing installation: pip 1.1 00:04:59 INFO - Uninstalling pip: 00:04:59 INFO - Successfully uninstalled pip 00:04:59 INFO - Running setup.py install for pip 00:04:59 INFO - warning: no files found matching 'pip/cacert.pem' 00:04:59 INFO - warning: no files found matching '*.html' under directory 'docs' 00:04:59 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 00:04:59 INFO - no previously-included directories found matching 'docs/_build/_sources' 00:04:59 INFO - Installing pip script to /builds/slave/test/build/venv/bin 00:04:59 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 00:04:59 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 00:04:59 INFO - Successfully installed pip 00:04:59 INFO - Cleaning up... 00:04:59 INFO - Return code: 0 00:04:59 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 00:04:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:04:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:04:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:04:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:04:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20601f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2229a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23cca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23d0090>, '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 0x23d0d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23caf90>, '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': '62c568580acbfdaac3eec7be000001dc-1505372454.848864-649808837', '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:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 00:04:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 00:04:59 INFO - Using env: {'DISPLAY': ':0', 00:04:59 INFO - 'HOME': '/home/cltbld', 00:04:59 INFO - 'LANG': 'en_US.UTF-8', 00:04:59 INFO - 'LANGUAGE': 'en_US:en', 00:04:59 INFO - 'LOGNAME': 'cltbld', 00:04:59 INFO - 'MAIL': '/var/mail/cltbld', 00:04:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:04:59 INFO - 'MOZ_NO_REMOTE': '1', 00:04:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:04:59 INFO - 'NO_EM_RESTART': '1', 00:04:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:04:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:04:59 INFO - 'PWD': '/builds/slave/test', 00:04:59 INFO - 'SHELL': '/bin/bash', 00:04:59 INFO - 'SHLVL': '1', 00:04:59 INFO - 'TERM': 'linux', 00:04:59 INFO - 'TMOUT': '86400', 00:04:59 INFO - 'USER': 'cltbld', 00:04:59 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1505372454.848864-649808837', 00:04:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:04:59 INFO - '_': '/tools/buildbot/bin/python'} 00:04:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:04:59 INFO - Downloading/unpacking psutil>=3.1.1 00:04:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:04:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:04:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:04:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 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:01 INFO - Return code: 0 00:05:01 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 00:05:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:05:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:05:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:05:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:05:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20601f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2229a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23cca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23d0090>, '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 0x23d0d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23caf90>, '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': '62c568580acbfdaac3eec7be000001dc-1505372454.848864-649808837', '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:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 00:05:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 00:05:01 INFO - Using env: {'DISPLAY': ':0', 00:05:01 INFO - 'HOME': '/home/cltbld', 00:05:01 INFO - 'LANG': 'en_US.UTF-8', 00:05:01 INFO - 'LANGUAGE': 'en_US:en', 00:05:01 INFO - 'LOGNAME': 'cltbld', 00:05:01 INFO - 'MAIL': '/var/mail/cltbld', 00:05:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:05:01 INFO - 'MOZ_NO_REMOTE': '1', 00:05:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:05:01 INFO - 'NO_EM_RESTART': '1', 00:05:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:05:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:05:01 INFO - 'PWD': '/builds/slave/test', 00:05:01 INFO - 'SHELL': '/bin/bash', 00:05:01 INFO - 'SHLVL': '1', 00:05:01 INFO - 'TERM': 'linux', 00:05:01 INFO - 'TMOUT': '86400', 00:05:01 INFO - 'USER': 'cltbld', 00:05:01 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1505372454.848864-649808837', 00:05:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:05:01 INFO - '_': '/tools/buildbot/bin/python'} 00:05:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:05:01 INFO - Downloading/unpacking mozsystemmonitor==0.3 00:05:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:05:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:05:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:05:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 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 0x20601f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2229a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23cca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23d0090>, '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 0x23d0d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23caf90>, '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': '62c568580acbfdaac3eec7be000001dc-1505372454.848864-649808837', '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': '62c568580acbfdaac3eec7be000001dc-1505372454.848864-649808837', 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 0x20601f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2229a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23cca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23d0090>, '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 0x23d0d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23caf90>, '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': '62c568580acbfdaac3eec7be000001dc-1505372454.848864-649808837', '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': '62c568580acbfdaac3eec7be000001dc-1505372454.848864-649808837', 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 0x20601f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2229a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23cca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23d0090>, '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 0x23d0d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23caf90>, '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': '62c568580acbfdaac3eec7be000001dc-1505372454.848864-649808837', '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': '62c568580acbfdaac3eec7be000001dc-1505372454.848864-649808837', 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:08 INFO - Downloading blobuploader-1.2.4.tar.gz 00:05:08 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 0x20601f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2229a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23cca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23d0090>, '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 0x23d0d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23caf90>, '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': '62c568580acbfdaac3eec7be000001dc-1505372454.848864-649808837', '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': '62c568580acbfdaac3eec7be000001dc-1505372454.848864-649808837', 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-sI3Fdq-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-8WetbF-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-FWQVXu-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-33sI3e-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-2gFsDJ-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-4Z2QA0-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-iF7MG_-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-ujGZYY-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-zEJDEa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 00:05:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 00:05:10 INFO - Running setup.py (path:/tmp/pip-0SwQfb-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-ObwOIc-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-LmkE0l-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-PE9rK3-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-VPqSUS-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-GzlQpj-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-Vme5FU-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-HRIL65-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:11 INFO - Installing dm script to /builds/slave/test/build/venv/bin 00:05:11 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:12 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 0x20601f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2229a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23cca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23d0090>, '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 0x23d0d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23caf90>, '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': '62c568580acbfdaac3eec7be000001dc-1505372454.848864-649808837', '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': '62c568580acbfdaac3eec7be000001dc-1505372454.848864-649808837', 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-34eoOI-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-KaiLGX-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-3erUfv-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-20_Cca-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-5AGey7-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-d6uNSH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 00:05:13 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:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 00:05:13 INFO - Running setup.py (path:/tmp/pip-b5IyzD-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-Xirc5Y-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-3wrsgb-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-6eFa6U-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-bFezEV-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-0f0avr-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-acPrFF-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-ppUBM1-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-fpTn_m-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-ozURWL-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-Z6Vz3H-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:15 INFO - Installing collected packages: blessings 00:05:15 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 0x20601f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2229a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23cca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23d0090>, '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 0x23d0d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23caf90>, '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': '62c568580acbfdaac3eec7be000001dc-1505372454.848864-649808837', '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': '62c568580acbfdaac3eec7be000001dc-1505372454.848864-649808837', 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 0x20601f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2229a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23cca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23d0090>, '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 0x23d0d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23caf90>, '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': '62c568580acbfdaac3eec7be000001dc-1505372454.848864-649808837', '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': '62c568580acbfdaac3eec7be000001dc-1505372454.848864-649808837', 00:05:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:05:17 INFO - '_': '/tools/buildbot/bin/python'} 00:05:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:05:18 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 00:05:18 INFO - Cleaning up... 00:05:18 INFO - Return code: 0 00:05:18 INFO - Running post-action listener: _resource_record_post_action 00:05:18 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.070843Z] Finished create-virtualenv step (success) 00:05:18 INFO - [mozharness: 2017-09-14 07:05:18.071348Z] 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.092240Z] Finished install step (success) 00:05:36 INFO - [mozharness: 2017-09-14 07:05:36.092579Z] 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.094296Z] Finished setup-mitmproxy step (success) 00:05:36 INFO - [mozharness: 2017-09-14 07:05:36.094607Z] 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 0x23d0090>, '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 0x23d0d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23caf90>, '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-Non-PGO', '--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-018', '--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-Non-PGO --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-018 --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_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 - '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': '62c568580acbfdaac3eec7be000001dc-1505372454.848864-649808837', 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-Non-PGO', '--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-018', '--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:52100' 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:52100/getInfo.html -profile /tmp/tmpVKEJGr/profile 00:05:36 INFO - TEST-INFO | started process 18544 (/builds/slave/test/build/application/firefox/firefox http://localhost:52100/getInfo.html) 00:05:42 INFO - TEST-INFO | 18544: exit 0 00:05:42 INFO - Browser initialized. 00:05:42 INFO - Running cycle 1/1 for dromaeo_css test... 00:05:42 INFO - Using env: {'DISPLAY': ':0', 00:05:42 INFO - 'HOME': '/home/cltbld', 00:05:42 INFO - 'JSGC_DISABLE_POISONING': '1', 00:05:42 INFO - 'LANG': 'en_US.UTF-8', 00:05:42 INFO - 'LANGUAGE': 'en_US:en', 00:05:42 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 00:05:42 INFO - 'LOGNAME': 'cltbld', 00:05:42 INFO - 'MAIL': '/var/mail/cltbld', 00:05:42 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 00:05:42 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 00:05:42 INFO - 'MOZ_CRASHREPORTER': '1', 00:05:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:05:42 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 00:05:42 INFO - 'MOZ_NO_REMOTE': '1', 00:05:42 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 00:05:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:05:42 INFO - 'NO_EM_RESTART': '1', 00:05:42 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:05:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:05:42 INFO - 'PWD': '/builds/slave/test', 00:05:42 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 00:05:42 INFO - 'RUST_BACKTRACE': 'full', 00:05:42 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 00:05:42 INFO - 'SHELL': '/bin/bash', 00:05:42 INFO - 'SHLVL': '1', 00:05:42 INFO - 'TERM': 'linux', 00:05:42 INFO - 'TMOUT': '86400', 00:05:42 INFO - 'USER': 'cltbld', 00:05:42 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1505372454.848864-649808837', 00:05:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:05:42 INFO - '_': '/tools/buildbot/bin/python'} 00:05:42 INFO - TEST-INFO | started process 18779 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpVKEJGr/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 00:05:43 INFO - PID 18779 | 00:05:43 INFO - PID 18779 | (/builds/slave/test/build/application/firefox/firefox:18830): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 00:05:43 INFO - PID 18779 | 00:05:53 INFO - PID 18779 | RSS: Main: 167800832 00:05:53 INFO - PID 18779 | 00:08:50 INFO - PID 18779 | Cycle 1(1): loaded http://localhost:52100/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52100/tests/dromaeo/cssquery-ext.html) 00:08:51 INFO - PID 18779 | RSS: Main: 171433984 00:08:51 INFO - PID 18779 | 00:11:53 INFO - PID 18779 | Cycle 1(1): loaded http://localhost:52100/tests/dromaeo/cssquery-ext.html (next: http://localhost:52100/tests/dromaeo/cssquery-jquery.html) 00:11:53 INFO - PID 18779 | RSS: Main: 169541632 00:11:53 INFO - PID 18779 | 00:14:55 INFO - PID 18779 | Cycle 1(1): loaded http://localhost:52100/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52100/tests/dromaeo/cssquery-mootools.html) 00:14:56 INFO - PID 18779 | RSS: Main: 171089920 00:14:56 INFO - PID 18779 | 00:17:57 INFO - PID 18779 | Cycle 1(1): loaded http://localhost:52100/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52100/tests/dromaeo/cssquery-prototype.html) 00:17:58 INFO - PID 18779 | RSS: Main: 171364352 00:17:58 INFO - PID 18779 | 00:21:01 INFO - PID 18779 | Cycle 1(1): loaded http://localhost:52100/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52100/tests/dromaeo/cssquery-yui.html) 00:21:02 INFO - PID 18779 | RSS: Main: 172638208 00:21:02 INFO - PID 18779 | 00:24:03 INFO - PID 18779 | Cycle 1(1): loaded http://localhost:52100/tests/dromaeo/cssquery-yui.html (next: http://localhost:52100/tests/dromaeo/cssquery-dojo.html) 00:24:04 INFO - PID 18779 | RSS: Main: 172531712 00:24:04 INFO - PID 18779 | 00:24:04 INFO - PID 18779 | __start_tp_report 00:24:04 INFO - PID 18779 | _x_x_mozilla_page_load 00:24:04 INFO - PID 18779 | _x_x_mozilla_page_load_details 00:24:04 INFO - PID 18779 | |i|pagename|runs| 00:24:04 INFO - PID 18779 | |0;dojo.html;3089.3666798306335;3134.498480243161;3138.215446138465;3165.841707914604;3170.571972783675;6307.400796924285;6371.968140159299;6396.616203027822;6398.392152745481;6436.871262574751;6205.317415084337;6267.749290028393;6296.275928268239;6304.401081897224;6328.493720502361;5787.450192231742;5788.884222315552;5814.360420353758;5815.244018277618;5882.941170588304;5832.620879642831;5870.148828419877;5900.055991041413;5912.083627037816;5933.732982015798;5710.114932185518;5732.942670573303;5755.510781583571;5862.486838707105;5911.615744976562;5776.682282474462;5801.158831969383;5821.767129314822;5834.27071616048;5878.294604647427;5635.492805647511;5730.4269573042775;5765.394633563499;5847.502962248214;5865.648061116347;6234.937650623481;6267.185265915402;6313.652749098797;6364.649944253064;6378.968105159491;6645.734170633169;6678.198616166092;6693.2302785179845;6711.127553418024;6746.359095885883;6613.173353330833;6636.701348439332;6686.331366863324;6730.697118629624;6787.694553745093;6141.754329826802;6237.625742455467;6268.968655156695;6354.618722876596;6361.936380636134;6906.894896816485;6943.79168624942;6949.270326615733;6950.409215216763;6972.965135174291;6551.737930482727;6571;6617.172853393326;6656.434203092791;6657.833554161088;6678.966605166943;6764.695588698521;6828.726850926007;6831.897521537181;6846.760363387258;6766.864662706718;6767.560108593024;6835.692393842289;6840.110785597841;6868.9313106869295;6736.865262694817;6758.7296508139125;6787.21946976104;6862.828429289208;6869.622170780655;5200.63595548308;5235.450277720861;5248.9737551312;5257.76340064698;5273.736313184326;4496.7301961882395;4563.726176429424;4593.63250939924;4611.331356953223;4631.490536041033;5743.253377060955;5756.539476841843;5804.04233301509;5808.970955145197;5810.21562089121;6627.138471998705;6707.463402927754;6753.561018533779;6778.694958726771;6789.321067893171;5839.416058394127;5876.7649294028615;5888.705564721832;5889.087191485327;5906.966280900825;5757.88484230313;5832.24180856486;5865.530757539386;5879.5002424794375;5897.970510147507;6424.486041116699;6455.9677201613695;6482.935170648328;6500.674966251669;6517.73929042833;6717.193936727526;6738.191417029988;6740.056392105012;6742.932570674328;6746.494012949147;6477.514186435942;6485.156929599122;6557.836054098686;6565.212174539086;6599.439047681001;6619.834504137435;6704.564203326768;6764.627945463047;6766.221884483348;6798.184217893884;6669.599824010381;6750.32496750321;6823.112995310578;6855.451563874778;6869.072675188786;6445.9033114504255;6465.77369792055;6502.089707441057;6520.380563846427;6521.413072823469;6443.548951573345;6545;6577.967110164419;6601.636909969998;6674;6441.516886233458;6502.122213501117;6510.18622672166;6579.934200657932;6580.76967306142;6598.736050557924;6656.567323123982;6680.5323627345615;6720.294369091175;6740.831479213059;6233.127362169209;6316.905246421215;6321.304656487875;6405.3594640535575;6458 00:24:04 INFO - PID 18779 | |1;ext.html;811.3225456743622;823.950562966222;848.507865438046;848.8684253940639;851.0383266908393;40573.188536229296;41152;41243.79378103109;41311.38032929508;41397.79301103498;38469.807650961775;39932;42914.78542607283;42999.570004299945;43096.13807723852;7701.422393320509;7841.294283514482;7861.842763144734;7863.095743989428;7867.213278672144;7664.65509052094;7783.182765809594;7804.76585702427;7811.023622047244;7813.374930005586;7814.6092695365005;7831.530108193527;7851.882221766678;7852;7856.332211762007;7773.300402963732;7779.3776497880035;7793.571353575523;7793.649285782153;7799.883001754978;7701.152873183945;7727.690892364299;7749.883751743729;7749.961250193769;7764.3788496920115;38788.41817372742;39170.60829391698;39188.02029949274;39231;39239.41140882889;3535.982320088383;3549.4498352755363;3549.591796943333;3550.2721942002086;3559.110222444389;31614.525782113287;31750.364992700015;31761.523577146363;31783;31809.204769880707;4986.5761410280165;5173.379194496647;5175.042617115846;5199.740012999335;5206.661566998171;193165;193479;194200;194245.02877485522;194363;47091;47264.291035634495;47281.290780638315;47353.28970065452;47405.5259447408;48668.26997595039;48894;48909.75545122252;49007.50992490101;49043;15895.284712187979;16118.435854745263;16187;16200.43298484571;16215.918920405322;13331.200127992352;13335;13346.599602011955;13354;13358.933205333911;12304;12462.75074498505;12535.310557919402;12590.874091258971;12615.116941814169;5260.237265596467;5262.158054711228;5332.280142180756;5346.7861285548925;5426.104692725656;990.2820455170088;1002.2132625888643;1007.3099926550336;1012.4839773163683;1021.1830535571513;21886.781132188473;22096.88951555232;22150.55698886013;22262.443438914157;22563.661545076837;1109.1570406491126;1111.4498323330004;1115.5291030367775;1116.7375666718315;1125.1224045244721;11719.941400292944;11724.941375293069;11814.94092529549;11887.643370698894;11956.461959211856;226363;226689;226887;227385;227481;52377;55046.72476637591;55302.44697553053;55308.170377444374;55535.722321388945;1412.9293535323193;1438.3239877257672;1439.2515891736448;1451.484722923368;1456.788765628999;25836.224913252634;26269.21192364232;26309.605355919295;26313.736862631893;26566;36721.44917826181;36732.81633591815;36738.448923266704;36905.261894762494;36926.446103307935;191025;193651;193779;193851.03074484537;194169;31956.36087278195;31957.68042319547;32027;32123.839380802947;32182.517262241552;39310.41034384429;40778.59221407748;40922;41362.79318603388;41433.79283103686;30021.099367019026;30272.84863575668;30310.84844575851;30832.845835771575;30836;30083.849580751958;30146;30231.69768302289;30250.69749302567;30774.692253077184;34283.828580856934;34558.654413455544;34707.13232169216;34708.47937280892;34732;30160;30177.547336790405;30336.84831575828;30354.392912142077;30404.543931841483;21950.89024554867;22189.112435503044;22270;22344.664830027887;22370 00:24:04 INFO - PID 18779 | |2;jquery.html;543.1770867136289;548.8847342058168;551.313614549885;576.3400905962673;593.4836692077891;21980.89009554952;22594.43513912153;22616.54766904661;22620.773792262073;22636.434089147737;23551.41121471964;23840.165594204205;24177.879110604466;24222.63666045006;25089;6419.807405777822;6494.642794646293;6532.542722009462;6536.411722944934;6560.2455717592375;6444.097826304321;6530.0204969254755;6531.248906375757;6538.803835884931;6538.967305163467;6784.762533311335;7038.788836334918;7053.083099197097;7053.753118640849;7054.82362940928;7002.054722612458;7018.719251229944;7021.052157958712;7021.5787052777;7043.823904402379;6883.931160688379;7115.8221044473785;7125.89311160333;7151.106111736033;7167;30807.229819254473;31395.529067064013;31399.37201255962;31558.842205788824;31603.20991975196;2022.2820898581085;2043.2542122125467;2045.3557129504306;2047.948801279965;2048.457158852905;19885.701714474293;20605.175792968264;20973.79026209749;21118;21247.468813279636;2414.263649586875;2442.0476014354417;2487.514934587756;2513.19577735123;2522.041624182817;124693;130771.34614326962;132864.00703989447;139243;147146;19883.701744473845;21267;21865.453363665718;22094.88952555227;22522.774772252396;40955;41046.79476602658;41091.38362924558;41127;41149.38275925864;11380.772384552263;11438.714032149262;11526.654200374001;11546.364949927834;11688.298702077902;9475;9482.241420686329;9567.521623918776;9611.759706007406;9699.418034917928;11416.257943233662;11655.59205427806;11788.941055294668;11880;11921.88078119225;4095.4675892133832;4207.936880946788;4331.198728235224;4478.939687743609;4506.662000349987;935.854942483916;956.6986399284203;958.242988039441;959.6209497248548;982.0768477631004;19445.416637500897;19457.318993835146;19590.902045489966;19628.803711962697;19891;1024.7899180667946;1026.3072426112344;1031.582209205273;1037.3931250218707;1043.3531210649446;10693.358398495959;10695.411752353539;10757.892421075689;10882.673519794418;10953.780924381468;448032;448672;450737;457373;462349;104787;108024;109299;109840;110398;1033.261218228955;1077.7413420779114;1135.2677522997785;1152.608113241502;1198.8381568488142;20532.692009619568;20607.278745243846;20609.48476288105;20702.896485517475;20770.58458830845;53886;54244;54472.45527544674;55200;55331.17003244874;67147.66426167838;67189.32810671831;67267.66366168138;68585;69201.3079869215;19328;20098.69851952251;20130.19479220815;20200;20212.797872021092;22729.431764206027;22821.65767513522;22976.770232297462;23033.65449518292;23107;18103.72844407361;18410.35563755262;18443.72334414958;18733.6253274931;18851.15169817334;14762.926185369004;14997.700045999238;15431.382744690087;15888.761668575211;16372.508824735278;18103.728444073087;18184.27262909469;18356;18376.724349135042;18730.531736706693;19608.11763470619;19640.214391424182;19774.209031638573;19776.505587360432;19802.20791168337;18239;18398.540036499195;18399.264029438673;18489.352872649393;18518.81481185171 00:24:04 INFO - PID 18779 | |3;mootools.html;1320.7556602028626;1388.9513867014657;1392.3525560614312;1396.6368744126537;1399.4052527675742;14749.852501474981;15361.078335299875;15393.076415415084;15396.461123860667;15441.845581544208;15109.093454392743;15242.923785381085;15247.771283430757;15303.15832629205;15351.69296614067;2778.1526634376505;2804.1167032384733;2806.28439747864;2807.4385122975386;2832.235296469962;2765.820221685594;2781.666200055996;2783.401568662737;2818.140467157516;2819.7744180465615;2750.147454289167;2851.686314505413;2854.7716182705335;2856.9857150714215;2857.8285302881895;2816.4367126574666;2821.4780265650716;2848.943021139586;2849.6437945256844;2850.1449565130483;2660.720624334456;2782.65216847894;2844.8293102413922;2846.3026558493093;2846.971530284691;15202.391904323813;15324.540263791992;15332.386704531806;15335.30991105403;15355.232238388147;7943.205679432069;8212.096669366365;8213.54825484598;8214.8357032859;8219.8356032879;5497.120460726304;5615.719214039323;5684.346300175492;5735.483806457439;5740.483356497935;1922.1158267197106;1932.2560814086537;1934.3713293179774;1939.3018513335187;1960.4510736993664;25749.3562660935;25757.61363579548;25977.610335844976;26373.34066648349;26434.6034809478;6717.429018533479;6748.898766518506;6781;6916.792496225121;6931.2375638679705;17023.14884255782;17040.659186816196;17144.485665430057;17165.65668686644;17172.570685732706;7840.529568225925;8079.959600202079;8090.029196496341;8094.433389662667;8120.14738452454;7410.96294518524;7464.402847772165;7473.215312392229;7498.887516687145;7565.735199268;5183.144781111075;5267.420583735786;5274.7098909560345;5319.627626066215;5326.707031113248;1569.0350434482712;1570.866476349523;1572.8191258005477;1578.9763153552476;1592.840715928398;814.5927036481759;835.0688981785387;848.0840692052568;856.0455092571862;864.9697260595975;7064.92935070653;7068.858622827514;7124.323189297009;7138.571685698875;7683.654235559413;702.5960072957968;707.9681414336367;710.2684235237714;725.600919494276;725.8258018075624;4064.3293856513937;4128.174365126986;4444.688871778944;4835.830745923946;5103.4386217516785;20181.899090504452;21268.042938067825;21403.357899263046;21940.122395104016;22060;21163.68254476184;21562.89218553897;21624.135034598756;21683.241086561895;21787.891060544913;10878.12974962017;11333.150013749002;11366.318020918772;11374.829377559177;11472.196946213686;7511.51175173612;7527.397808175223;7534;7548.622568871425;7598.430117741081;17461.650766984843;18168.818311816714;18240.726389103907;18427.355042573447;18552.721709174642;18569.16438760286;18719.34482293168;18758.71861922045;18773.812261877207;18853.90573047126;10724;10812.297200681931;10927.508262128382;10942.671719848417;10949.507272172612;13538.93230533841;13598.184108953494;13762.65593360174;13767.862321376659;13772.724545509234;10576.15390768752;10694.091002264584;10772.569097236023;10875.945620271848;10961.780764384826;10407.531661075118;10419.635312764018;10485.003924627148;10522.526486308288;10671.679849604525;8866.42368246062;9032.45805251687;9037.457752534607;9037.77405564866;9046;6262.968685156545;6272.372762723691;6322.083297921868;6327.367263273636;6417.486601071996;6654.966725166343;6757.570779256268;6797.422219111431;6863.210730765826;6908.689108990007 00:24:04 INFO - PID 18779 | |4;prototype.html;495.142279429896;505.3506244475847;528.7594144664178;530.1014779947988;532.9467053294674;6225.84435389115;6382.234131904178;6388.744450221997;6401.2396590937515;6421.357864213582;6236.25164980203;6267.153934218879;6272.466840318579;6281.748730050804;6314.200452870933;5152.433232344439;5214.113600687892;5235.319408476912;5243.9213411798855;5250.6324557281005;4869.391326084239;4966.701997880121;5098.617603679721;5187.584993200554;5190.4290528042075;4928.782048078361;4938.555530002299;4951.158303088484;4951.529604687567;4978.850634480953;4961.578265847407;4972.651914365996;4976.751162441863;4983.152864013126;4995.225740010323;4279.7218180818145;4387.846425375128;4393.648508119343;4399.406080179167;4486.102779444124;6113.358097399798;6115.449609535163;6132.938670613281;6141.78503752371;6141.877162456771;5625.971870140664;5628.774849006035;5653.660780353151;5666.490015898589;5672.829815105553;6502.93497065028;6525.641089740062;6539.378759017885;6546.607203567801;6549.770758023446;4542.750148741818;4767.094252092092;4793.784279707386;4817.638677099197;4828.855134345975;6640.833979150511;6661.467082633378;6769.7292108315605;6851.931480685229;6860.416864566468;4895.485973972753;4955.108080545464;4957.3059771632;4962.106820772224;4965.109367273233;5011.198208286657;5016.247562865599;5030.320906677625;5037.79848806051;5067.138586440314;5654.123610840326;5665.773369065274;5671.177679236487;5674.716264186856;5692.715364231854;6544.476441884638;6553.770618028346;6573.80278591643;6613.371729685672;6616.669166541654;1703.5570751604423;1709.7093494106032;1718.7937447506379;1718.957026074358;1759.225940586138;1145.7371690910552;1200.591798788416;1202.4769225386985;1221.450347343699;1224.6326102169314;5651.886962260732;5677.325189069152;5696.772129114872;5699.632088298861;5726.3128424588485;6573.737050517926;6649.3018233085795;6695.857325655744;6706.26231114577;6744.494162937799;5594.748236329375;5609.326880774333;5612.803551875746;5710.457506536873;5713.971430142906;3474.4788281757433;3474.9671442206086;3484.564429446319;3547.94678079829;3553.982230088833;6360.236771587439;6388.8083357499345;6393.936060639334;6454.677266136769;6469.644169570719;6537.640429776313;6628.270890202074;6632.535722499379;6715.664216789141;6732.966335168293;5895.41045895407;6379.872402552016;6402.391772781578;6420.678966051679;6454.16056423917;6472;6507.967460162668;6630.90053649186;6636.203655561363;6657.434118100015;6332.208473940757;6525;6526.804195874131;6534.150560427114;6642.867142657024;6354.841128971812;6383.7127329271225;6460.25707043696;6461.095446637569;6467.676616169078;4921.50784921505;4926.236433352836;4933.313352315243;4942.92585611209;4955;6408.807735767934;6627.6354800484505;6673.8998915015345;6715.395614394728;6806.591604503746;6423.7430502781235;6469.5794773339585;6504.837379065372;6513.641749703622;6521.380468855451;6423.261324947691;6440.32376600469;6480.935190648033;6556.3443655634055;6564.179477565304;6284.465820405134;6318.957372033563;6405.455536279468;6408.455281301141;6467.902981455376;6540.247871494839;6558.44253238461;6571.178602674666;6573.3426657333885;6629.933700662931;6179.536534760001;6274.780382686584;6277.30949595535;6355.968220158869;6407.423331899965 00:24:04 INFO - PID 18779 | |5;yui.html;896.4442045931519;899.1727610598249;923.1184219070788;923.3351986569668;924.5423515359898;18275.177617007233;18983.2406703732;18996.715049274273;19003.429897103073;19060.809391906078;17644.11779411031;17778.46664600064;17782.64434711308;17865.553361165978;17885.28458861644;975.0834215837108;979.7158823941048;980.1717548671361;980.4166520920041;980.8675828763097;977.5112443778111;978.7455261631991;981.6662334806165;981.6907674082642;982.7837875667342;980.9705708828747;1015.2385710716962;1037.3672060043368;1037.3775734559279;1042.10899680773;1036.9688909332733;1037.201354956679;1038.174651152332;1038.4755698372312;1041.8541404203418;727.828960194354;742.6286856571714;755.1240560949327;757.6211894052974;757.9469437139403;18981.715274270897;19002.71495927562;19097.427077187705;19121.617567648707;19267.325643602406;21464.678029829563;21582.460438489008;22256.666150007764;22460.663090053662;22511.54976900469;17622.91188544049;17690.91154544219;17803.19885605138;17909.283628654837;18073.819261807344;3803.9239215215816;3820.178661587772;3830.157365379612;3833.6549710525906;3833.9041523962123;104081.47959260155;142939.28530357385;143293.2835335827;146085.2695736525;147377;16304.673906521803;16406.83593164077;16588.58528536796;16723.916380418264;16731;30661.23346916345;31505.212369690482;31557.211069723442;31745.206369840478;31770.364592708018;8523.275521580612;8542.871856922151;8551.74344769658;8568;8735.781605459788;4239.8092085856215;4281.636060934793;4316.784160792011;4332.263515202423;4340.8697739067875;5184.170532714747;5235.586391674226;5269.841904742864;5282.867928301746;5286.101362768339;1082.71849319176;1101.564881871656;1113.4098927568402;1116.2576886370473;1117.212365282474;683.1494788987742;705.6648092156288;711.5481669140133;714.4427346669606;737.7012310014453;10954.890451095547;11756.529738810523;11826.785660746937;11886.940565297291;12638.873611263954;693.2062788107588;701.2987012987013;702.1363722621103;705.8870580707062;709.8331892005375;5259.342582177228;5272.815451459181;5281.419043905167;5284.048871203144;5287.41838397776;121038;123435;126027;127875;128288;108540.45729771459;109525;109789;111217.44391277991;114875.42562287135;91912;92786;94658;96263.9999999986;96784;9943.25425593069;9963.103320701171;10029.247806414402;10030;10031.648892288735;43256.13487730291;43652.345214821165;44611.553884460736;46041.53958460373;46074;56857.71571142118;56962.145567815685;56962.715186423804;58887.70556147192;59360.40639593549;15393.769093463383;15864.682706345578;15903.681926361176;15961.8403815965;15970.68058638844;16239.59401014984;16378;16462;16484.42304519336;16515.58711032234;14480.637984050061;14732.705345893237;14786.482473113389;14795.186264755543;14863.554093377215;15043.473478428203;15202.923985380003;15224.391024358902;15262.618434538781;15287.541373758804;16122.758158627395;16182.919085404968;16196.352145914032;16327.510174694778;16345.754813678042;12022.519099235933;12350.320732359807;12477.875221248034;12486.500539978662;12592.496300148257;12539.33503224088;12573.748525029265;12575.622731318075;12765.48938042505;13013.089083764424 00:24:04 INFO - PID 18779 | __end_tp_report 00:24:04 INFO - PID 18779 | __start_cc_report 00:24:04 INFO - PID 18779 | _x_x_mozilla_cycle_collect,341 00:24:04 INFO - PID 18779 | __end_cc_report 00:24:04 INFO - PID 18779 | __startTimestamp1505373844152__endTimestamp 00:24:04 INFO - PID 18779 | 00:24:04 INFO - PID 18779 | ------- Summary: start ------- 00:24:04 INFO - PID 18779 | Number of tests: 6 00:24:04 INFO - PID 18779 | 00:24:04 INFO - PID 18779 | [#0] dojo.html Cycles:165 Average:6205.45 Median:6445.90 stddev:750.15 (11.6%) stddev-sans-first:711.51 00:24:04 INFO - PID 18779 | Values: 3089.4 3134.5 3138.2 3165.8 3170.6 6307.4 6372.0 6396.6 6398.4 6436.9 6205.3 6267.7 6296.3 6304.4 6328.5 5787.5 5788.9 5814.4 5815.2 5882.9 5832.6 5870.1 5900.1 5912.1 5933.7 5710.1 5732.9 5755.5 5862.5 5911.6 5776.7 5801.2 5821.8 5834.3 5878.3 5635.5 5730.4 5765.4 5847.5 5865.6 6234.9 6267.2 6313.7 6364.6 6379.0 6645.7 6678.2 6693.2 6711.1 6746.4 6613.2 6636.7 6686.3 6730.7 6787.7 6141.8 6237.6 6269.0 6354.6 6361.9 6906.9 6943.8 6949.3 6950.4 6973.0 6551.7 6571.0 6617.2 6656.4 6657.8 6679.0 6764.7 6828.7 6831.9 6846.8 6766.9 6767.6 6835.7 6840.1 6868.9 6736.9 6758.7 6787.2 6862.8 6869.6 5200.6 5235.5 5249.0 5257.8 5273.7 4496.7 4563.7 4593.6 4611.3 4631.5 5743.3 5756.5 5804.0 5809.0 5810.2 6627.1 6707.5 6753.6 6778.7 6789.3 5839.4 5876.8 5888.7 5889.1 5907.0 5757.9 5832.2 5865.5 5879.5 5898.0 6424.5 6456.0 6482.9 6500.7 6517.7 6717.2 6738.2 6740.1 6742.9 6746.5 6477.5 6485.2 6557.8 6565.2 6599.4 6619.8 6704.6 6764.6 6766.2 6798.2 6669.6 6750.3 6823.1 6855.5 6869.1 6445.9 6465.8 6502.1 6520.4 6521.4 6443.5 6545.0 6578.0 6601.6 6674.0 6441.5 6502.1 6510.2 6579.9 6580.8 6598.7 6656.6 6680.5 6720.3 6740.8 6233.1 6316.9 6321.3 6405.4 6458.0 00:24:04 INFO - PID 18779 | 00:24:04 INFO - PID 18779 | [#1] ext.html Cycles:180 Average:37101.13 Median:34632.89 stddev:53189.61 (153.6%) stddev-sans-first:53269.02 00:24:04 INFO - PID 18779 | Values: 811.3 824.0 848.5 848.9 851.0 40573.2 41152.0 41243.8 41311.4 41397.8 38469.8 39932.0 42914.8 42999.6 43096.1 7701.4 7841.3 7861.8 7863.1 7867.2 7664.7 7783.2 7804.8 7811.0 7813.4 7814.6 7831.5 7851.9 7852.0 7856.3 7773.3 7779.4 7793.6 7793.6 7799.9 7701.2 7727.7 7749.9 7750.0 7764.4 38788.4 39170.6 39188.0 39231.0 39239.4 3536.0 3549.4 3549.6 3550.3 3559.1 31614.5 31750.4 31761.5 31783.0 31809.2 4986.6 5173.4 5175.0 5199.7 5206.7 193165.0 193479.0 194200.0 194245.0 194363.0 47091.0 47264.3 47281.3 47353.3 47405.5 48668.3 48894.0 48909.8 49007.5 49043.0 15895.3 16118.4 16187.0 16200.4 16215.9 13331.2 13335.0 13346.6 13354.0 13358.9 12304.0 12462.8 12535.3 12590.9 12615.1 5260.2 5262.2 5332.3 5346.8 5426.1 990.3 1002.2 1007.3 1012.5 1021.2 21886.8 22096.9 22150.6 22262.4 22563.7 1109.2 1111.4 1115.5 1116.7 1125.1 11719.9 11724.9 11814.9 11887.6 11956.5 226363.0 226689.0 226887.0 227385.0 227481.0 52377.0 55046.7 55302.4 55308.2 55535.7 1412.9 1438.3 1439.3 1451.5 1456.8 25836.2 26269.2 26309.6 26313.7 26566.0 36721.4 36732.8 36738.4 36905.3 36926.4 191025.0 193651.0 193779.0 193851.0 194169.0 31956.4 31957.7 32027.0 32123.8 32182.5 39310.4 40778.6 40922.0 41362.8 41433.8 30021.1 30272.8 30310.8 30832.8 30836.0 30083.8 30146.0 30231.7 30250.7 30774.7 34283.8 34558.7 34707.1 34708.5 34732.0 30160.0 30177.5 30336.8 30354.4 30404.5 21950.9 22189.1 22270.0 22344.7 22370.0 00:24:04 INFO - PID 18779 | 00:24:04 INFO - PID 18779 | [#2] jquery.html Cycles:180 Average:34573.60 Median:22558.60 stddev:76409.56 (338.7%) stddev-sans-first:76581.19 00:24:04 INFO - PID 18779 | Values: 543.2 548.9 551.3 576.3 593.5 21980.9 22594.4 22616.5 22620.8 22636.4 23551.4 23840.2 24177.9 24222.6 25089.0 6419.8 6494.6 6532.5 6536.4 6560.2 6444.1 6530.0 6531.2 6538.8 6539.0 6784.8 7038.8 7053.1 7053.8 7054.8 7002.1 7018.7 7021.1 7021.6 7043.8 6883.9 7115.8 7125.9 7151.1 7167.0 30807.2 31395.5 31399.4 31558.8 31603.2 2022.3 2043.3 2045.4 2047.9 2048.5 19885.7 20605.2 20973.8 21118.0 21247.5 2414.3 2442.0 2487.5 2513.2 2522.0 124693.0 130771.3 132864.0 139243.0 147146.0 19883.7 21267.0 21865.5 22094.9 22522.8 40955.0 41046.8 41091.4 41127.0 41149.4 11380.8 11438.7 11526.7 11546.4 11688.3 9475.0 9482.2 9567.5 9611.8 9699.4 11416.3 11655.6 11788.9 11880.0 11921.9 4095.5 4207.9 4331.2 4478.9 4506.7 935.9 956.7 958.2 959.6 982.1 19445.4 19457.3 19590.9 19628.8 19891.0 1024.8 1026.3 1031.6 1037.4 1043.4 10693.4 10695.4 10757.9 10882.7 10953.8 448032.0 448672.0 450737.0 457373.0 462349.0 104787.0 108024.0 109299.0 109840.0 110398.0 1033.3 1077.7 1135.3 1152.6 1198.8 20532.7 20607.3 20609.5 20702.9 20770.6 53886.0 54244.0 54472.5 55200.0 55331.2 67147.7 67189.3 67267.7 68585.0 69201.3 19328.0 20098.7 20130.2 20200.0 20212.8 22729.4 22821.7 22976.8 23033.7 23107.0 18103.7 18410.4 18443.7 18733.6 18851.2 14762.9 14997.7 15431.4 15888.8 16372.5 18103.7 18184.3 18356.0 18376.7 18730.5 19608.1 19640.2 19774.2 19776.5 19802.2 18239.0 18398.5 18399.3 18489.4 18518.8 00:24:04 INFO - PID 18779 | 00:24:04 INFO - PID 18779 | [#3] mootools.html Cycles:180 Average:9147.54 Median:2783.03 stddev:6605.40 (237.3%) stddev-sans-first:6597.75 00:24:04 INFO - PID 18779 | Values: 1320.8 1389.0 1392.4 1396.6 1399.4 14749.9 15361.1 15393.1 15396.5 15441.8 15109.1 15242.9 15247.8 15303.2 15351.7 2778.2 2804.1 2806.3 2807.4 2832.2 2765.8 2781.7 2783.4 2818.1 2819.8 2750.1 2851.7 2854.8 2857.0 2857.8 2816.4 2821.5 2848.9 2849.6 2850.1 2660.7 2782.7 2844.8 2846.3 2847.0 15202.4 15324.5 15332.4 15335.3 15355.2 7943.2 8212.1 8213.5 8214.8 8219.8 5497.1 5615.7 5684.3 5735.5 5740.5 1922.1 1932.3 1934.4 1939.3 1960.5 25749.4 25757.6 25977.6 26373.3 26434.6 6717.4 6748.9 6781.0 6916.8 6931.2 17023.1 17040.7 17144.5 17165.7 17172.6 7840.5 8080.0 8090.0 8094.4 8120.1 7411.0 7464.4 7473.2 7498.9 7565.7 5183.1 5267.4 5274.7 5319.6 5326.7 1569.0 1570.9 1572.8 1579.0 1592.8 814.6 835.1 848.1 856.0 865.0 7064.9 7068.9 7124.3 7138.6 7683.7 702.6 708.0 710.3 725.6 725.8 4064.3 4128.2 4444.7 4835.8 5103.4 20181.9 21268.0 21403.4 21940.1 22060.0 21163.7 21562.9 21624.1 21683.2 21787.9 10878.1 11333.2 11366.3 11374.8 11472.2 7511.5 7527.4 7534.0 7548.6 7598.4 17461.7 18168.8 18240.7 18427.4 18552.7 18569.2 18719.3 18758.7 18773.8 18853.9 10724.0 10812.3 10927.5 10942.7 10949.5 13538.9 13598.2 13762.7 13767.9 13772.7 10576.2 10694.1 10772.6 10875.9 10961.8 10407.5 10419.6 10485.0 10522.5 10671.7 8866.4 9032.5 9037.5 9037.8 9046.0 6263.0 6272.4 6322.1 6327.4 6417.5 6655.0 6757.6 6797.4 6863.2 6908.7 00:24:04 INFO - PID 18779 | 00:24:04 INFO - PID 18779 | [#4] prototype.html Cycles:180 Average:5470.86 Median:6160.71 stddev:1531.02 (24.9%) stddev-sans-first:1489.07 00:24:04 INFO - PID 18779 | Values: 495.1 505.4 528.8 530.1 532.9 6225.8 6382.2 6388.7 6401.2 6421.4 6236.3 6267.2 6272.5 6281.7 6314.2 5152.4 5214.1 5235.3 5243.9 5250.6 4869.4 4966.7 5098.6 5187.6 5190.4 4928.8 4938.6 4951.2 4951.5 4978.9 4961.6 4972.7 4976.8 4983.2 4995.2 4279.7 4387.8 4393.6 4399.4 4486.1 6113.4 6115.4 6132.9 6141.8 6141.9 5626.0 5628.8 5653.7 5666.5 5672.8 6502.9 6525.6 6539.4 6546.6 6549.8 4542.8 4767.1 4793.8 4817.6 4828.9 6640.8 6661.5 6769.7 6851.9 6860.4 4895.5 4955.1 4957.3 4962.1 4965.1 5011.2 5016.2 5030.3 5037.8 5067.1 5654.1 5665.8 5671.2 5674.7 5692.7 6544.5 6553.8 6573.8 6613.4 6616.7 1703.6 1709.7 1718.8 1719.0 1759.2 1145.7 1200.6 1202.5 1221.5 1224.6 5651.9 5677.3 5696.8 5699.6 5726.3 6573.7 6649.3 6695.9 6706.3 6744.5 5594.7 5609.3 5612.8 5710.5 5714.0 3474.5 3475.0 3484.6 3547.9 3554.0 6360.2 6388.8 6393.9 6454.7 6469.6 6537.6 6628.3 6632.5 6715.7 6733.0 5895.4 6379.9 6402.4 6420.7 6454.2 6472.0 6508.0 6630.9 6636.2 6657.4 6332.2 6525.0 6526.8 6534.2 6642.9 6354.8 6383.7 6460.3 6461.1 6467.7 4921.5 4926.2 4933.3 4942.9 4955.0 6408.8 6627.6 6673.9 6715.4 6806.6 6423.7 6469.6 6504.8 6513.6 6521.4 6423.3 6440.3 6480.9 6556.3 6564.2 6284.5 6319.0 6405.5 6408.5 6467.9 6540.2 6558.4 6571.2 6573.3 6629.9 6179.5 6274.8 6277.3 6356.0 6407.4 00:24:04 INFO - PID 18779 | 00:24:04 INFO - PID 18779 | [#5] yui.html Cycles:180 Average:24284.82 Median:18999.72 stddev:35481.82 (186.7%) stddev-sans-first:35537.90 00:24:04 INFO - PID 18779 | Values: 896.4 899.2 923.1 923.3 924.5 18275.2 18983.2 18996.7 19003.4 19060.8 17644.1 17778.5 17782.6 17865.6 17885.3 975.1 979.7 980.2 980.4 980.9 977.5 978.7 981.7 981.7 982.8 981.0 1015.2 1037.4 1037.4 1042.1 1037.0 1037.2 1038.2 1038.5 1041.9 727.8 742.6 755.1 757.6 757.9 18981.7 19002.7 19097.4 19121.6 19267.3 21464.7 21582.5 22256.7 22460.7 22511.5 17622.9 17690.9 17803.2 17909.3 18073.8 3803.9 3820.2 3830.2 3833.7 3833.9 104081.5 142939.3 143293.3 146085.3 147377.0 16304.7 16406.8 16588.6 16723.9 16731.0 30661.2 31505.2 31557.2 31745.2 31770.4 8523.3 8542.9 8551.7 8568.0 8735.8 4239.8 4281.6 4316.8 4332.3 4340.9 5184.2 5235.6 5269.8 5282.9 5286.1 1082.7 1101.6 1113.4 1116.3 1117.2 683.1 705.7 711.5 714.4 737.7 10954.9 11756.5 11826.8 11886.9 12638.9 693.2 701.3 702.1 705.9 709.8 5259.3 5272.8 5281.4 5284.0 5287.4 121038.0 123435.0 126027.0 127875.0 128288.0 108540.5 109525.0 109789.0 111217.4 114875.4 91912.0 92786.0 94658.0 96264.0 96784.0 9943.3 9963.1 10029.2 10030.0 10031.6 43256.1 43652.3 44611.6 46041.5 46074.0 56857.7 56962.1 56962.7 58887.7 59360.4 15393.8 15864.7 15903.7 15961.8 15970.7 16239.6 16378.0 16462.0 16484.4 16515.6 14480.6 14732.7 14786.5 14795.2 14863.6 15043.5 15202.9 15224.4 15262.6 15287.5 16122.8 16182.9 16196.4 16327.5 16345.8 12022.5 12350.3 12477.9 12486.5 12592.5 12539.3 12573.7 12575.6 12765.5 13013.1 00:24:04 INFO - PID 18779 | -------- Summary: end -------- 00:24:04 INFO - PID 18779 | 00:24:04 INFO - TEST-INFO | 18779: exit 0 00:24:04 INFO - TEST-OK | dromaeo_css | took 1108387ms 00:24:04 INFO - TEST-START | kraken 00:24:04 INFO - Initialising browser for kraken test... 00:24:04 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:52100/getInfo.html -profile /tmp/tmpAGeNE8/profile 00:24:04 INFO - TEST-INFO | started process 19143 (/builds/slave/test/build/application/firefox/firefox http://localhost:52100/getInfo.html) 00:24:10 INFO - TEST-INFO | 19143: exit 0 00:24:10 INFO - Browser initialized. 00:24:10 INFO - Running cycle 1/1 for kraken test... 00:24:10 INFO - Using env: {'DISPLAY': ':0', 00:24:10 INFO - 'HOME': '/home/cltbld', 00:24:10 INFO - 'JSGC_DISABLE_POISONING': '1', 00:24:10 INFO - 'LANG': 'en_US.UTF-8', 00:24:10 INFO - 'LANGUAGE': 'en_US:en', 00:24:10 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 00:24:10 INFO - 'LOGNAME': 'cltbld', 00:24:10 INFO - 'MAIL': '/var/mail/cltbld', 00:24:10 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 00:24:10 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 00:24:10 INFO - 'MOZ_CRASHREPORTER': '1', 00:24:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:24:10 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 00:24:10 INFO - 'MOZ_NO_REMOTE': '1', 00:24:10 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 00:24:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:24:10 INFO - 'NO_EM_RESTART': '1', 00:24:10 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:24:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:24:10 INFO - 'PWD': '/builds/slave/test', 00:24:10 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 00:24:10 INFO - 'RUST_BACKTRACE': 'full', 00:24:10 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 00:24:10 INFO - 'SHELL': '/bin/bash', 00:24:10 INFO - 'SHLVL': '1', 00:24:10 INFO - 'TERM': 'linux', 00:24:10 INFO - 'TMOUT': '86400', 00:24:10 INFO - 'USER': 'cltbld', 00:24:10 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1505372454.848864-649808837', 00:24:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:24:10 INFO - '_': '/tools/buildbot/bin/python'} 00:24:10 INFO - TEST-INFO | started process 19376 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpAGeNE8/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 00:24:11 INFO - PID 19376 | 00:24:11 INFO - PID 19376 | (/builds/slave/test/build/application/firefox/firefox:19425): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 00:24:11 INFO - PID 19376 | 00:24:21 INFO - PID 19376 | RSS: Main: 173338624 00:24:21 INFO - PID 19376 | 00:24:24 INFO - PID 19376 | Cycle 1(1): loaded http://localhost:52100/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52100/tests/kraken/driver.html?testName=audio-beat-detection) 00:24:25 INFO - PID 19376 | RSS: Main: 178495488 00:24:25 INFO - PID 19376 | 00:24:27 INFO - PID 19376 | Cycle 1(1): loaded http://localhost:52100/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52100/tests/kraken/driver.html?testName=audio-dft) 00:24:28 INFO - PID 19376 | RSS: Main: 178331648 00:24:28 INFO - PID 19376 | 00:24:31 INFO - PID 19376 | Cycle 1(1): loaded http://localhost:52100/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52100/tests/kraken/driver.html?testName=audio-fft) 00:24:32 INFO - PID 19376 | RSS: Main: 174653440 00:24:32 INFO - PID 19376 | 00:24:34 INFO - PID 19376 | Cycle 1(1): loaded http://localhost:52100/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52100/tests/kraken/driver.html?testName=audio-oscillator) 00:24:34 INFO - PID 19376 | RSS: Main: 175026176 00:24:34 INFO - PID 19376 | 00:24:36 INFO - PID 19376 | Cycle 1(1): loaded http://localhost:52100/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52100/tests/kraken/driver.html?testName=imaging-gaussian-blur) 00:24:37 INFO - PID 19376 | RSS: Main: 175063040 00:24:37 INFO - PID 19376 | 00:24:40 INFO - PID 19376 | Cycle 1(1): loaded http://localhost:52100/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52100/tests/kraken/driver.html?testName=imaging-darkroom) 00:24:41 INFO - PID 19376 | RSS: Main: 177856512 00:24:41 INFO - PID 19376 | 00:24:44 INFO - PID 19376 | Cycle 1(1): loaded http://localhost:52100/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52100/tests/kraken/driver.html?testName=imaging-desaturate) 00:24:45 INFO - PID 19376 | RSS: Main: 177696768 00:24:45 INFO - PID 19376 | 00:24:48 INFO - PID 19376 | Cycle 1(1): loaded http://localhost:52100/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52100/tests/kraken/driver.html?testName=json-parse-financial) 00:24:49 INFO - PID 19376 | RSS: Main: 177782784 00:24:49 INFO - PID 19376 | 00:24:50 INFO - PID 19376 | Cycle 1(1): loaded http://localhost:52100/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52100/tests/kraken/driver.html?testName=json-stringify-tinderbox) 00:24:51 INFO - PID 19376 | RSS: Main: 177881088 00:24:51 INFO - PID 19376 | 00:24:53 INFO - PID 19376 | Cycle 1(1): loaded http://localhost:52100/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52100/tests/kraken/driver.html?testName=stanford-crypto-aes) 00:24:53 INFO - PID 19376 | RSS: Main: 178163712 00:24:53 INFO - PID 19376 | 00:24:55 INFO - PID 19376 | Cycle 1(1): loaded http://localhost:52100/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52100/tests/kraken/driver.html?testName=stanford-crypto-ccm) 00:24:56 INFO - PID 19376 | RSS: Main: 174657536 00:24:56 INFO - PID 19376 | 00:24:59 INFO - PID 19376 | Cycle 1(1): loaded http://localhost:52100/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52100/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 00:24:59 INFO - PID 19376 | RSS: Main: 175071232 00:24:59 INFO - PID 19376 | 00:25:02 INFO - PID 19376 | Cycle 1(1): loaded http://localhost:52100/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52100/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 00:25:03 INFO - PID 19376 | RSS: Main: 175136768 00:25:03 INFO - PID 19376 | 00:25:05 INFO - PID 19376 | Cycle 1(1): loaded http://localhost:52100/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52100/tests/kraken/driver.html?testName=ai-astar) 00:25:05 INFO - PID 19376 | RSS: Main: 176644096 00:25:05 INFO - PID 19376 | 00:25:05 INFO - PID 19376 | __start_tp_report 00:25:05 INFO - PID 19376 | _x_x_mozilla_page_load 00:25:05 INFO - PID 19376 | _x_x_mozilla_page_load_details 00:25:05 INFO - PID 19376 | |i|pagename|runs| 00:25:05 INFO - PID 19376 | |0;ai-astar;108;106;109;108;107;112;110;106;107;108 00:25:05 INFO - PID 19376 | |1;audio-beat-detection;118;118;123;116;116;114;122;119;116;147 00:25:05 INFO - PID 19376 | |2;audio-dft;164;162;163;162;161;161;164;165;170;165 00:25:05 INFO - PID 19376 | |3;audio-fft;75;74;73;75;76;74;73;74;74;75 00:25:05 INFO - PID 19376 | |4;audio-oscillator;79;79;78;78;78;78;78;79;79;79 00:25:05 INFO - PID 19376 | |5;imaging-gaussian-blur;116;113;114;113;113;113;113;114;114;114 00:25:05 INFO - PID 19376 | |6;imaging-darkroom;149;148;149;148;151;149;149;152;148;149 00:25:05 INFO - PID 19376 | |7;imaging-desaturate;94;94;94;93;94;94;95;95;94;93 00:25:05 INFO - PID 19376 | |8;json-parse-financial;53;53;52;53;52;53;52;54;52;52 00:25:05 INFO - PID 19376 | |9;json-stringify-tinderbox;38;38;37;37;37;38;38;38;38;37 00:25:05 INFO - PID 19376 | |10;stanford-crypto-aes;76;78;80;75;74;74;77;77;74;72 00:25:05 INFO - PID 19376 | |11;stanford-crypto-ccm;116;111;113;117;116;111;115;116;113;114 00:25:05 INFO - PID 19376 | |12;stanford-crypto-pbkdf2;169;169;170;169;171;168;173;166;169;168 00:25:05 INFO - PID 19376 | |13;stanford-crypto-sha256-iterative;70;65;64;66;69;63;67;64;68;67 00:25:05 INFO - PID 19376 | __end_tp_report 00:25:05 INFO - PID 19376 | __start_cc_report 00:25:05 INFO - PID 19376 | _x_x_mozilla_cycle_collect,942 00:25:05 INFO - PID 19376 | __end_cc_report 00:25:05 INFO - PID 19376 | __startTimestamp1505373905319__endTimestamp 00:25:05 INFO - PID 19376 | 00:25:05 INFO - PID 19376 | ------- Summary: start ------- 00:25:05 INFO - PID 19376 | Number of tests: 14 00:25:05 INFO - PID 19376 | 00:25:05 INFO - PID 19376 | [#0] ai-astar Cycles:10 Average:108.10 Median:108.00 stddev:1.85 (1.7%) stddev-sans-first:1.96 00:25:05 INFO - PID 19376 | Values: 108.0 106.0 109.0 108.0 107.0 112.0 110.0 106.0 107.0 108.0 00:25:05 INFO - PID 19376 | 00:25:05 INFO - PID 19376 | [#1] audio-beat-detection Cycles:10 Average:120.90 Median:118.50 stddev:9.59 (8.1%) stddev-sans-first:10.11 00:25:05 INFO - PID 19376 | Values: 118.0 118.0 123.0 116.0 116.0 114.0 122.0 119.0 116.0 147.0 00:25:05 INFO - PID 19376 | 00:25:05 INFO - PID 19376 | [#2] audio-dft Cycles:10 Average:163.70 Median:164.00 stddev:2.67 (1.6%) stddev-sans-first:2.83 00:25:05 INFO - PID 19376 | Values: 164.0 162.0 163.0 162.0 161.0 161.0 164.0 165.0 170.0 165.0 00:25:05 INFO - PID 19376 | 00:25:05 INFO - PID 19376 | [#3] audio-fft Cycles:10 Average:74.30 Median:74.50 stddev:0.95 (1.3%) stddev-sans-first:0.97 00:25:05 INFO - PID 19376 | Values: 75.0 74.0 73.0 75.0 76.0 74.0 73.0 74.0 74.0 75.0 00:25:05 INFO - PID 19376 | 00:25:05 INFO - PID 19376 | [#4] audio-oscillator Cycles:10 Average:78.50 Median:79.00 stddev:0.53 (0.7%) stddev-sans-first:0.53 00:25:05 INFO - PID 19376 | Values: 79.0 79.0 78.0 78.0 78.0 78.0 78.0 79.0 79.0 79.0 00:25:05 INFO - PID 19376 | 00:25:05 INFO - PID 19376 | [#5] imaging-gaussian-blur Cycles:10 Average:113.70 Median:114.00 stddev:0.95 (0.8%) stddev-sans-first:0.53 00:25:05 INFO - PID 19376 | Values: 116.0 113.0 114.0 113.0 113.0 113.0 113.0 114.0 114.0 114.0 00:25:05 INFO - PID 19376 | 00:25:05 INFO - PID 19376 | [#6] imaging-darkroom Cycles:10 Average:149.20 Median:149.00 stddev:1.32 (0.9%) stddev-sans-first:1.39 00:25:05 INFO - PID 19376 | Values: 149.0 148.0 149.0 148.0 151.0 149.0 149.0 152.0 148.0 149.0 00:25:05 INFO - PID 19376 | 00:25:05 INFO - PID 19376 | [#7] imaging-desaturate Cycles:10 Average:94.00 Median:94.00 stddev:0.67 (0.7%) stddev-sans-first:0.71 00:25:05 INFO - PID 19376 | Values: 94.0 94.0 94.0 93.0 94.0 94.0 95.0 95.0 94.0 93.0 00:25:05 INFO - PID 19376 | 00:25:05 INFO - PID 19376 | [#8] json-parse-financial Cycles:10 Average:52.60 Median:53.00 stddev:0.70 (1.3%) stddev-sans-first:0.73 00:25:05 INFO - PID 19376 | Values: 53.0 53.0 52.0 53.0 52.0 53.0 52.0 54.0 52.0 52.0 00:25:05 INFO - PID 19376 | 00:25:05 INFO - PID 19376 | [#9] json-stringify-tinderbox Cycles:10 Average:37.60 Median:38.00 stddev:0.52 (1.4%) stddev-sans-first:0.53 00:25:05 INFO - PID 19376 | Values: 38.0 38.0 37.0 37.0 37.0 38.0 38.0 38.0 38.0 37.0 00:25:05 INFO - PID 19376 | 00:25:05 INFO - PID 19376 | [#10] stanford-crypto-aes Cycles:10 Average:75.70 Median:76.50 stddev:2.36 (3.1%) stddev-sans-first:2.50 00:25:05 INFO - PID 19376 | Values: 76.0 78.0 80.0 75.0 74.0 74.0 77.0 77.0 74.0 72.0 00:25:05 INFO - PID 19376 | 00:25:05 INFO - PID 19376 | [#11] stanford-crypto-ccm Cycles:10 Average:114.20 Median:115.50 stddev:2.15 (1.9%) stddev-sans-first:2.18 00:25:05 INFO - PID 19376 | Values: 116.0 111.0 113.0 117.0 116.0 111.0 115.0 116.0 113.0 114.0 00:25:05 INFO - PID 19376 | 00:25:05 INFO - PID 19376 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:169.20 Median:169.00 stddev:1.87 (1.1%) stddev-sans-first:1.99 00:25:05 INFO - PID 19376 | Values: 169.0 169.0 170.0 169.0 171.0 168.0 173.0 166.0 169.0 168.0 00:25:05 INFO - PID 19376 | 00:25:05 INFO - PID 19376 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.30 Median:67.00 stddev:2.31 (3.5%) stddev-sans-first:2.03 00:25:05 INFO - PID 19376 | Values: 70.0 65.0 64.0 66.0 69.0 63.0 67.0 64.0 68.0 67.0 00:25:05 INFO - PID 19376 | -------- Summary: end -------- 00:25:05 INFO - PID 19376 | 00:25:05 INFO - PID 19376 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 00:25:05 INFO - TEST-INFO | 19376: exit 0 00:25:05 INFO - TEST-OK | kraken | took 61136ms 00:25:05 INFO - SUITE-END | took 1169s 00:25:06 INFO - Completed test suite (00:19:30) 00:25:06 INFO - javascript benchmark 00:25:06 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8544.20254181396, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3089.3666798306335, 3134.498480243161, 3138.215446138465, 3165.841707914604, 3170.571972783675, 6307.400796924285, 6371.968140159299, 6396.616203027822, 6398.392152745481, 6436.871262574751, 6205.317415084337, 6267.749290028393, 6296.275928268239, 6304.401081897224, 6328.493720502361, 5787.450192231742, 5788.884222315552, 5814.360420353758, 5815.244018277618, 5882.941170588304, 5832.620879642831, 5870.148828419877, 5900.055991041413, 5912.083627037816, 5933.732982015798, 5710.114932185518, 5732.942670573303, 5755.510781583571, 5862.486838707105, 5911.615744976562, 5776.682282474462, 5801.158831969383, 5821.767129314822, 5834.27071616048, 5878.294604647427, 5635.492805647511, 5730.4269573042775, 5765.394633563499, 5847.502962248214, 5865.648061116347, 6234.937650623481, 6267.185265915402, 6313.652749098797, 6364.649944253064, 6378.968105159491, 6645.734170633169, 6678.198616166092, 6693.2302785179845, 6711.127553418024, 6746.359095885883, 6613.173353330833, 6636.701348439332, 6686.331366863324, 6730.697118629624, 6787.694553745093, 6141.754329826802, 6237.625742455467, 6268.968655156695, 6354.618722876596, 6361.936380636134, 6906.894896816485, 6943.79168624942, 6949.270326615733, 6950.409215216763, 6972.965135174291, 6551.737930482727, 6571.0, 6617.172853393326, 6656.434203092791, 6657.833554161088, 6678.966605166943, 6764.695588698521, 6828.726850926007, 6831.897521537181, 6846.760363387258, 6766.864662706718, 6767.560108593024, 6835.692393842289, 6840.110785597841, 6868.9313106869295, 6736.865262694817, 6758.7296508139125, 6787.21946976104, 6862.828429289208, 6869.622170780655, 5200.63595548308, 5235.450277720861, 5248.9737551312, 5257.76340064698, 5273.736313184326, 4496.7301961882395, 4563.726176429424, 4593.63250939924, 4611.331356953223, 4631.490536041033, 5743.253377060955, 5756.539476841843, 5804.04233301509, 5808.970955145197, 5810.21562089121, 6627.138471998705, 6707.463402927754, 6753.561018533779, 6778.694958726771, 6789.321067893171, 5839.416058394127, 5876.7649294028615, 5888.705564721832, 5889.087191485327, 5906.966280900825, 5757.88484230313, 5832.24180856486, 5865.530757539386, 5879.5002424794375, 5897.970510147507, 6424.486041116699, 6455.9677201613695, 6482.935170648328, 6500.674966251669, 6517.73929042833, 6717.193936727526, 6738.191417029988, 6740.056392105012, 6742.932570674328, 6746.494012949147, 6477.514186435942, 6485.156929599122, 6557.836054098686, 6565.212174539086, 6599.439047681001, 6619.834504137435, 6704.564203326768, 6764.627945463047, 6766.221884483348, 6798.184217893884, 6669.599824010381, 6750.32496750321, 6823.112995310578, 6855.451563874778, 6869.072675188786, 6445.9033114504255, 6465.77369792055, 6502.089707441057, 6520.380563846427, 6521.413072823469, 6443.548951573345, 6545.0, 6577.967110164419, 6601.636909969998, 6674.0, 6441.516886233458, 6502.122213501117, 6510.18622672166, 6579.934200657932, 6580.76967306142, 6598.736050557924, 6656.567323123982, 6680.5323627345615, 6720.294369091175, 6740.831479213059, 6233.127362169209, 6316.905246421215, 6321.304656487875, 6405.3594640535575, 6458.0], "value": 6147.374450864306, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [811.3225456743622, 823.950562966222, 848.507865438046, 848.8684253940639, 851.0383266908393, 40573.188536229296, 41152.0, 41243.79378103109, 41311.38032929508, 41397.79301103498, 38469.807650961775, 39932.0, 42914.78542607283, 42999.570004299945, 43096.13807723852, 7701.422393320509, 7841.294283514482, 7861.842763144734, 7863.095743989428, 7867.213278672144, 7664.65509052094, 7783.182765809594, 7804.76585702427, 7811.023622047244, 7813.374930005586, 7814.6092695365005, 7831.530108193527, 7851.882221766678, 7852.0, 7856.332211762007, 7773.300402963732, 7779.3776497880035, 7793.571353575523, 7793.649285782153, 7799.883001754978, 7701.152873183945, 7727.690892364299, 7749.883751743729, 7749.961250193769, 7764.3788496920115, 38788.41817372742, 39170.60829391698, 39188.02029949274, 39231.0, 39239.41140882889, 3535.982320088383, 3549.4498352755363, 3549.591796943333, 3550.2721942002086, 3559.110222444389, 31614.525782113287, 31750.364992700015, 31761.523577146363, 31783.0, 31809.204769880707, 4986.5761410280165, 5173.379194496647, 5175.042617115846, 5199.740012999335, 5206.661566998171, 193165.0, 193479.0, 194200.0, 194245.02877485522, 194363.0, 47091.0, 47264.291035634495, 47281.290780638315, 47353.28970065452, 47405.5259447408, 48668.26997595039, 48894.0, 48909.75545122252, 49007.50992490101, 49043.0, 15895.284712187979, 16118.435854745263, 16187.0, 16200.43298484571, 16215.918920405322, 13331.200127992352, 13335.0, 13346.599602011955, 13354.0, 13358.933205333911, 12304.0, 12462.75074498505, 12535.310557919402, 12590.874091258971, 12615.116941814169, 5260.237265596467, 5262.158054711228, 5332.280142180756, 5346.7861285548925, 5426.104692725656, 990.2820455170088, 1002.2132625888643, 1007.3099926550336, 1012.4839773163683, 1021.1830535571513, 21886.781132188473, 22096.88951555232, 22150.55698886013, 22262.443438914157, 22563.661545076837, 1109.1570406491126, 1111.4498323330004, 1115.5291030367775, 1116.7375666718315, 1125.1224045244721, 11719.941400292944, 11724.941375293069, 11814.94092529549, 11887.643370698894, 11956.461959211856, 226363.0, 226689.0, 226887.0, 227385.0, 227481.0, 52377.0, 55046.72476637591, 55302.44697553053, 55308.170377444374, 55535.722321388945, 1412.9293535323193, 1438.3239877257672, 1439.2515891736448, 1451.484722923368, 1456.788765628999, 25836.224913252634, 26269.21192364232, 26309.605355919295, 26313.736862631893, 26566.0, 36721.44917826181, 36732.81633591815, 36738.448923266704, 36905.261894762494, 36926.446103307935, 191025.0, 193651.0, 193779.0, 193851.03074484537, 194169.0, 31956.36087278195, 31957.68042319547, 32027.0, 32123.839380802947, 32182.517262241552, 39310.41034384429, 40778.59221407748, 40922.0, 41362.79318603388, 41433.79283103686, 30021.099367019026, 30272.84863575668, 30310.84844575851, 30832.845835771575, 30836.0, 30083.849580751958, 30146.0, 30231.69768302289, 30250.69749302567, 30774.692253077184, 34283.828580856934, 34558.654413455544, 34707.13232169216, 34708.47937280892, 34732.0, 30160.0, 30177.547336790405, 30336.84831575828, 30354.392912142077, 30404.543931841483, 21950.89024554867, 22189.112435503044, 22270.0, 22344.664830027887, 22370.0], "value": 16917.27952149771, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [543.1770867136289, 548.8847342058168, 551.313614549885, 576.3400905962673, 593.4836692077891, 21980.89009554952, 22594.43513912153, 22616.54766904661, 22620.773792262073, 22636.434089147737, 23551.41121471964, 23840.165594204205, 24177.879110604466, 24222.63666045006, 25089.0, 6419.807405777822, 6494.642794646293, 6532.542722009462, 6536.411722944934, 6560.2455717592375, 6444.097826304321, 6530.0204969254755, 6531.248906375757, 6538.803835884931, 6538.967305163467, 6784.762533311335, 7038.788836334918, 7053.083099197097, 7053.753118640849, 7054.82362940928, 7002.054722612458, 7018.719251229944, 7021.052157958712, 7021.5787052777, 7043.823904402379, 6883.931160688379, 7115.8221044473785, 7125.89311160333, 7151.106111736033, 7167.0, 30807.229819254473, 31395.529067064013, 31399.37201255962, 31558.842205788824, 31603.20991975196, 2022.2820898581085, 2043.2542122125467, 2045.3557129504306, 2047.948801279965, 2048.457158852905, 19885.701714474293, 20605.175792968264, 20973.79026209749, 21118.0, 21247.468813279636, 2414.263649586875, 2442.0476014354417, 2487.514934587756, 2513.19577735123, 2522.041624182817, 124693.0, 130771.34614326962, 132864.00703989447, 139243.0, 147146.0, 19883.701744473845, 21267.0, 21865.453363665718, 22094.88952555227, 22522.774772252396, 40955.0, 41046.79476602658, 41091.38362924558, 41127.0, 41149.38275925864, 11380.772384552263, 11438.714032149262, 11526.654200374001, 11546.364949927834, 11688.298702077902, 9475.0, 9482.241420686329, 9567.521623918776, 9611.759706007406, 9699.418034917928, 11416.257943233662, 11655.59205427806, 11788.941055294668, 11880.0, 11921.88078119225, 4095.4675892133832, 4207.936880946788, 4331.198728235224, 4478.939687743609, 4506.662000349987, 935.854942483916, 956.6986399284203, 958.242988039441, 959.6209497248548, 982.0768477631004, 19445.416637500897, 19457.318993835146, 19590.902045489966, 19628.803711962697, 19891.0, 1024.7899180667946, 1026.3072426112344, 1031.582209205273, 1037.3931250218707, 1043.3531210649446, 10693.358398495959, 10695.411752353539, 10757.892421075689, 10882.673519794418, 10953.780924381468, 448032.0, 448672.0, 450737.0, 457373.0, 462349.0, 104787.0, 108024.0, 109299.0, 109840.0, 110398.0, 1033.261218228955, 1077.7413420779114, 1135.2677522997785, 1152.608113241502, 1198.8381568488142, 20532.692009619568, 20607.278745243846, 20609.48476288105, 20702.896485517475, 20770.58458830845, 53886.0, 54244.0, 54472.45527544674, 55200.0, 55331.17003244874, 67147.66426167838, 67189.32810671831, 67267.66366168138, 68585.0, 69201.3079869215, 19328.0, 20098.69851952251, 20130.19479220815, 20200.0, 20212.797872021092, 22729.431764206027, 22821.65767513522, 22976.770232297462, 23033.65449518292, 23107.0, 18103.72844407361, 18410.35563755262, 18443.72334414958, 18733.6253274931, 18851.15169817334, 14762.926185369004, 14997.700045999238, 15431.382744690087, 15888.761668575211, 16372.508824735278, 18103.728444073087, 18184.27262909469, 18356.0, 18376.724349135042, 18730.531736706693, 19608.11763470619, 19640.214391424182, 19774.209031638573, 19776.505587360432, 19802.20791168337, 18239.0, 18398.540036499195, 18399.264029438673, 18489.352872649393, 18518.81481185171], "value": 12822.378193819493, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1320.7556602028626, 1388.9513867014657, 1392.3525560614312, 1396.6368744126537, 1399.4052527675742, 14749.852501474981, 15361.078335299875, 15393.076415415084, 15396.461123860667, 15441.845581544208, 15109.093454392743, 15242.923785381085, 15247.771283430757, 15303.15832629205, 15351.69296614067, 2778.1526634376505, 2804.1167032384733, 2806.28439747864, 2807.4385122975386, 2832.235296469962, 2765.820221685594, 2781.666200055996, 2783.401568662737, 2818.140467157516, 2819.7744180465615, 2750.147454289167, 2851.686314505413, 2854.7716182705335, 2856.9857150714215, 2857.8285302881895, 2816.4367126574666, 2821.4780265650716, 2848.943021139586, 2849.6437945256844, 2850.1449565130483, 2660.720624334456, 2782.65216847894, 2844.8293102413922, 2846.3026558493093, 2846.971530284691, 15202.391904323813, 15324.540263791992, 15332.386704531806, 15335.30991105403, 15355.232238388147, 7943.205679432069, 8212.096669366365, 8213.54825484598, 8214.8357032859, 8219.8356032879, 5497.120460726304, 5615.719214039323, 5684.346300175492, 5735.483806457439, 5740.483356497935, 1922.1158267197106, 1932.2560814086537, 1934.3713293179774, 1939.3018513335187, 1960.4510736993664, 25749.3562660935, 25757.61363579548, 25977.610335844976, 26373.34066648349, 26434.6034809478, 6717.429018533479, 6748.898766518506, 6781.0, 6916.792496225121, 6931.2375638679705, 17023.14884255782, 17040.659186816196, 17144.485665430057, 17165.65668686644, 17172.570685732706, 7840.529568225925, 8079.959600202079, 8090.029196496341, 8094.433389662667, 8120.14738452454, 7410.96294518524, 7464.402847772165, 7473.215312392229, 7498.887516687145, 7565.735199268, 5183.144781111075, 5267.420583735786, 5274.7098909560345, 5319.627626066215, 5326.707031113248, 1569.0350434482712, 1570.866476349523, 1572.8191258005477, 1578.9763153552476, 1592.840715928398, 814.5927036481759, 835.0688981785387, 848.0840692052568, 856.0455092571862, 864.9697260595975, 7064.92935070653, 7068.858622827514, 7124.323189297009, 7138.571685698875, 7683.654235559413, 702.5960072957968, 707.9681414336367, 710.2684235237714, 725.600919494276, 725.8258018075624, 4064.3293856513937, 4128.174365126986, 4444.688871778944, 4835.830745923946, 5103.4386217516785, 20181.899090504452, 21268.042938067825, 21403.357899263046, 21940.122395104016, 22060.0, 21163.68254476184, 21562.89218553897, 21624.135034598756, 21683.241086561895, 21787.891060544913, 10878.12974962017, 11333.150013749002, 11366.318020918772, 11374.829377559177, 11472.196946213686, 7511.51175173612, 7527.397808175223, 7534.0, 7548.622568871425, 7598.430117741081, 17461.650766984843, 18168.818311816714, 18240.726389103907, 18427.355042573447, 18552.721709174642, 18569.16438760286, 18719.34482293168, 18758.71861922045, 18773.812261877207, 18853.90573047126, 10724.0, 10812.297200681931, 10927.508262128382, 10942.671719848417, 10949.507272172612, 13538.93230533841, 13598.184108953494, 13762.65593360174, 13767.862321376659, 13772.724545509234, 10576.15390768752, 10694.091002264584, 10772.569097236023, 10875.945620271848, 10961.780764384826, 10407.531661075118, 10419.635312764018, 10485.003924627148, 10522.526486308288, 10671.679849604525, 8866.42368246062, 9032.45805251687, 9037.457752534607, 9037.77405564866, 9046.0, 6262.968685156545, 6272.372762723691, 6322.083297921868, 6327.367263273636, 6417.486601071996, 6654.966725166343, 6757.570779256268, 6797.422219111431, 6863.210730765826, 6908.689108990007], "value": 6517.114161811119, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [495.142279429896, 505.3506244475847, 528.7594144664178, 530.1014779947988, 532.9467053294674, 6225.84435389115, 6382.234131904178, 6388.744450221997, 6401.2396590937515, 6421.357864213582, 6236.25164980203, 6267.153934218879, 6272.466840318579, 6281.748730050804, 6314.200452870933, 5152.433232344439, 5214.113600687892, 5235.319408476912, 5243.9213411798855, 5250.6324557281005, 4869.391326084239, 4966.701997880121, 5098.617603679721, 5187.584993200554, 5190.4290528042075, 4928.782048078361, 4938.555530002299, 4951.158303088484, 4951.529604687567, 4978.850634480953, 4961.578265847407, 4972.651914365996, 4976.751162441863, 4983.152864013126, 4995.225740010323, 4279.7218180818145, 4387.846425375128, 4393.648508119343, 4399.406080179167, 4486.102779444124, 6113.358097399798, 6115.449609535163, 6132.938670613281, 6141.78503752371, 6141.877162456771, 5625.971870140664, 5628.774849006035, 5653.660780353151, 5666.490015898589, 5672.829815105553, 6502.93497065028, 6525.641089740062, 6539.378759017885, 6546.607203567801, 6549.770758023446, 4542.750148741818, 4767.094252092092, 4793.784279707386, 4817.638677099197, 4828.855134345975, 6640.833979150511, 6661.467082633378, 6769.7292108315605, 6851.931480685229, 6860.416864566468, 4895.485973972753, 4955.108080545464, 4957.3059771632, 4962.106820772224, 4965.109367273233, 5011.198208286657, 5016.247562865599, 5030.320906677625, 5037.79848806051, 5067.138586440314, 5654.123610840326, 5665.773369065274, 5671.177679236487, 5674.716264186856, 5692.715364231854, 6544.476441884638, 6553.770618028346, 6573.80278591643, 6613.371729685672, 6616.669166541654, 1703.5570751604423, 1709.7093494106032, 1718.7937447506379, 1718.957026074358, 1759.225940586138, 1145.7371690910552, 1200.591798788416, 1202.4769225386985, 1221.450347343699, 1224.6326102169314, 5651.886962260732, 5677.325189069152, 5696.772129114872, 5699.632088298861, 5726.3128424588485, 6573.737050517926, 6649.3018233085795, 6695.857325655744, 6706.26231114577, 6744.494162937799, 5594.748236329375, 5609.326880774333, 5612.803551875746, 5710.457506536873, 5713.971430142906, 3474.4788281757433, 3474.9671442206086, 3484.564429446319, 3547.94678079829, 3553.982230088833, 6360.236771587439, 6388.8083357499345, 6393.936060639334, 6454.677266136769, 6469.644169570719, 6537.640429776313, 6628.270890202074, 6632.535722499379, 6715.664216789141, 6732.966335168293, 5895.41045895407, 6379.872402552016, 6402.391772781578, 6420.678966051679, 6454.16056423917, 6472.0, 6507.967460162668, 6630.90053649186, 6636.203655561363, 6657.434118100015, 6332.208473940757, 6525.0, 6526.804195874131, 6534.150560427114, 6642.867142657024, 6354.841128971812, 6383.7127329271225, 6460.25707043696, 6461.095446637569, 6467.676616169078, 4921.50784921505, 4926.236433352836, 4933.313352315243, 4942.92585611209, 4955.0, 6408.807735767934, 6627.6354800484505, 6673.8998915015345, 6715.395614394728, 6806.591604503746, 6423.7430502781235, 6469.5794773339585, 6504.837379065372, 6513.641749703622, 6521.380468855451, 6423.261324947691, 6440.32376600469, 6480.935190648033, 6556.3443655634055, 6564.179477565304, 6284.465820405134, 6318.957372033563, 6405.455536279468, 6408.455281301141, 6467.902981455376, 6540.247871494839, 6558.44253238461, 6571.178602674666, 6573.3426657333885, 6629.933700662931, 6179.536534760001, 6274.780382686584, 6277.30949595535, 6355.968220158869, 6407.423331899965], "value": 5019.956495360926, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [896.4442045931519, 899.1727610598249, 923.1184219070788, 923.3351986569668, 924.5423515359898, 18275.177617007233, 18983.2406703732, 18996.715049274273, 19003.429897103073, 19060.809391906078, 17644.11779411031, 17778.46664600064, 17782.64434711308, 17865.553361165978, 17885.28458861644, 975.0834215837108, 979.7158823941048, 980.1717548671361, 980.4166520920041, 980.8675828763097, 977.5112443778111, 978.7455261631991, 981.6662334806165, 981.6907674082642, 982.7837875667342, 980.9705708828747, 1015.2385710716962, 1037.3672060043368, 1037.3775734559279, 1042.10899680773, 1036.9688909332733, 1037.201354956679, 1038.174651152332, 1038.4755698372312, 1041.8541404203418, 727.828960194354, 742.6286856571714, 755.1240560949327, 757.6211894052974, 757.9469437139403, 18981.715274270897, 19002.71495927562, 19097.427077187705, 19121.617567648707, 19267.325643602406, 21464.678029829563, 21582.460438489008, 22256.666150007764, 22460.663090053662, 22511.54976900469, 17622.91188544049, 17690.91154544219, 17803.19885605138, 17909.283628654837, 18073.819261807344, 3803.9239215215816, 3820.178661587772, 3830.157365379612, 3833.6549710525906, 3833.9041523962123, 104081.47959260155, 142939.28530357385, 143293.2835335827, 146085.2695736525, 147377.0, 16304.673906521803, 16406.83593164077, 16588.58528536796, 16723.916380418264, 16731.0, 30661.23346916345, 31505.212369690482, 31557.211069723442, 31745.206369840478, 31770.364592708018, 8523.275521580612, 8542.871856922151, 8551.74344769658, 8568.0, 8735.781605459788, 4239.8092085856215, 4281.636060934793, 4316.784160792011, 4332.263515202423, 4340.8697739067875, 5184.170532714747, 5235.586391674226, 5269.841904742864, 5282.867928301746, 5286.101362768339, 1082.71849319176, 1101.564881871656, 1113.4098927568402, 1116.2576886370473, 1117.212365282474, 683.1494788987742, 705.6648092156288, 711.5481669140133, 714.4427346669606, 737.7012310014453, 10954.890451095547, 11756.529738810523, 11826.785660746937, 11886.940565297291, 12638.873611263954, 693.2062788107588, 701.2987012987013, 702.1363722621103, 705.8870580707062, 709.8331892005375, 5259.342582177228, 5272.815451459181, 5281.419043905167, 5284.048871203144, 5287.41838397776, 121038.0, 123435.0, 126027.0, 127875.0, 128288.0, 108540.45729771459, 109525.0, 109789.0, 111217.44391277991, 114875.42562287135, 91912.0, 92786.0, 94658.0, 96263.9999999986, 96784.0, 9943.25425593069, 9963.103320701171, 10029.247806414402, 10030.0, 10031.648892288735, 43256.13487730291, 43652.345214821165, 44611.553884460736, 46041.53958460373, 46074.0, 56857.71571142118, 56962.145567815685, 56962.715186423804, 58887.70556147192, 59360.40639593549, 15393.769093463383, 15864.682706345578, 15903.681926361176, 15961.8403815965, 15970.68058638844, 16239.59401014984, 16378.0, 16462.0, 16484.42304519336, 16515.58711032234, 14480.637984050061, 14732.705345893237, 14786.482473113389, 14795.186264755543, 14863.554093377215, 15043.473478428203, 15202.923985380003, 15224.391024358902, 15262.618434538781, 15287.541373758804, 16122.758158627395, 16182.919085404968, 16196.352145914032, 16327.510174694778, 16345.754813678042, 12022.519099235933, 12350.320732359807, 12477.875221248034, 12486.500539978662, 12592.496300148257, 12539.33503224088, 12573.748525029265, 12575.622731318075, 12765.48938042505, 13013.089083764424], "value": 8917.8074671761, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1418.0000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 106.0, 109.0, 108.0, 107.0, 112.0, 110.0, 106.0, 107.0, 108.0], "value": 108.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 123.0, 116.0, 116.0, 114.0, 122.0, 119.0, 116.0, 147.0], "value": 120.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 162.0, 163.0, 162.0, 161.0, 161.0, 164.0, 165.0, 170.0, 165.0], "value": 163.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 73.0, 75.0, 76.0, 74.0, 73.0, 74.0, 74.0, 75.0], "value": 74.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 79.0, 78.0, 78.0, 78.0, 78.0, 78.0, 79.0, 79.0, 79.0], "value": 78.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 113.0, 114.0, 113.0, 113.0, 113.0, 113.0, 114.0, 114.0, 114.0], "value": 113.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 148.0, 149.0, 148.0, 151.0, 149.0, 149.0, 152.0, 148.0, 149.0], "value": 149.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 93.0, 94.0, 94.0, 95.0, 95.0, 94.0, 93.0], "value": 94.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 53.0, 52.0, 53.0, 52.0, 53.0, 52.0, 54.0, 52.0, 52.0], "value": 52.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [38.0, 38.0, 37.0, 37.0, 37.0, 38.0, 38.0, 38.0, 38.0, 37.0], "value": 37.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 78.0, 80.0, 75.0, 74.0, 74.0, 77.0, 77.0, 74.0, 72.0], "value": 75.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 111.0, 113.0, 117.0, 116.0, 111.0, 115.0, 116.0, 113.0, 114.0], "value": 114.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 169.0, 170.0, 169.0, 171.0, 168.0, 173.0, 166.0, 169.0, 168.0], "value": 169.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 65.0, 64.0, 66.0, 69.0, 63.0, 67.0, 64.0, 68.0, 67.0], "value": 66.3, "unit": "score"}]}]} 00:25:06 INFO - Return code: 0 00:25:06 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 00:25:06 INFO - # TBPL SUCCESS # 00:25:06 INFO - Running post-action listener: _package_coverage_data 00:25:06 INFO - Running post-action listener: _resource_record_post_action 00:25:06 INFO - [mozharness: 2017-09-14 07:25:06.615280Z] Finished run-tests step (success) 00:25:06 INFO - Running post-run listener: _resource_record_post_run 00:25:06 INFO - Total resource usage - Wall time: 1188s; CPU: 13.0%; Read bytes: 151552; Write bytes: 338305024; Read time: 280; Write time: 327008 00:25:06 INFO - TinderboxPrint: CPU usage
13.1% 00:25:06 INFO - TinderboxPrint: I/O read bytes / time
151,552 / 280 00:25:06 INFO - TinderboxPrint: I/O write bytes / time
338,305,024 / 327,008 00:25:06 INFO - TinderboxPrint: CPU idle
8,229.9 (86.9%) 00:25:06 INFO - TinderboxPrint: CPU user
1,191.3 (12.6%) 00:25:06 INFO - TinderboxPrint: Swap in / out
0 / 0 00:25:06 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 13049856; Read time: 0; Write time: 1720 00:25:06 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:06 INFO - run-tests - Wall time: 1171s; CPU: 13.0%; Read bytes: 147456; Write bytes: 324427776; Read time: 264; Write time: 325260 00:25:07 INFO - Running post-run listener: _upload_blobber_files 00:25:07 INFO - Blob upload gear active. 00:25:07 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 00:25:07 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:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 00:25:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 00:25:07 INFO - (blobuploader) - INFO - Open directory for files ... 00:25:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 00:25:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:25:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:25:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 00:25:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:25:08 INFO - (blobuploader) - INFO - Done attempting. 00:25:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 00:25:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:25:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:25:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 00:25:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:25:09 INFO - (blobuploader) - INFO - Done attempting. 00:25:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 00:25:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:25:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:25:17 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 00:25:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:25:17 INFO - (blobuploader) - INFO - Done attempting. 00:25:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 00:25:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:25:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:25:18 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 00:25:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:25:18 INFO - (blobuploader) - INFO - Done attempting. 00:25:18 INFO - (blobuploader) - INFO - Iteration through files over. 00:25:18 INFO - Return code: 0 00:25:18 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 00:25:18 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 00:25:18 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/89094d025a1624ad33e6eac51323e1c7b92251842bc5c6145a48ecc656e7730f421a1fe1ec7d0f4a9750c4b37b4724c852c02ffc55c4268aa69483d9e75accea", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1fece8f4f8190f85fb1867575890bd2713eb8df7401630802f7798aa970507dba1676389fa8ab1e821953467788ab5505f6a9ecac5253218acc0f9e16e1a0863", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e83ed23057e64c6172359322fe25347a901fd4fad8c8aef11c4c21411c571a7fcf0cf4172d184f70e14a5dd0ddd7f6e438df7cdb4d9f9187d82d91fd457c29dd", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c354a7da37ef6e589d610d684cd9c11fbbd1a3040456dfac3b34d94c66bcc65b03caf563adcc82e51036582194a3092319f0843305d5272d30e8e63ef65b6f57"} 00:25:18 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 00:25:18 INFO - Writing to file /builds/slave/test/properties/blobber_files 00:25:18 INFO - Contents: 00:25:18 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/89094d025a1624ad33e6eac51323e1c7b92251842bc5c6145a48ecc656e7730f421a1fe1ec7d0f4a9750c4b37b4724c852c02ffc55c4268aa69483d9e75accea", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1fece8f4f8190f85fb1867575890bd2713eb8df7401630802f7798aa970507dba1676389fa8ab1e821953467788ab5505f6a9ecac5253218acc0f9e16e1a0863", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e83ed23057e64c6172359322fe25347a901fd4fad8c8aef11c4c21411c571a7fcf0cf4172d184f70e14a5dd0ddd7f6e438df7cdb4d9f9187d82d91fd457c29dd", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c354a7da37ef6e589d610d684cd9c11fbbd1a3040456dfac3b34d94c66bcc65b03caf563adcc82e51036582194a3092319f0843305d5272d30e8e63ef65b6f57"} 00:25:18 INFO - Running post-run listener: copy_logs_to_upload_dir 00:25:18 INFO - Copying logs to upload dir... 00:25:18 INFO - mkdir: /builds/slave/test/build/upload/logs 00:25:18 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1240.046387 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2017-09-14 00:25:18.476301) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-14 00:25:18.481029) ========= 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=62c568580acbfdaac3eec7be000001dc-1505372454.848864-649808837 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-Non-PGO/sha512/89094d025a1624ad33e6eac51323e1c7b92251842bc5c6145a48ecc656e7730f421a1fe1ec7d0f4a9750c4b37b4724c852c02ffc55c4268aa69483d9e75accea", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1fece8f4f8190f85fb1867575890bd2713eb8df7401630802f7798aa970507dba1676389fa8ab1e821953467788ab5505f6a9ecac5253218acc0f9e16e1a0863", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e83ed23057e64c6172359322fe25347a901fd4fad8c8aef11c4c21411c571a7fcf0cf4172d184f70e14a5dd0ddd7f6e438df7cdb4d9f9187d82d91fd457c29dd", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c354a7da37ef6e589d610d684cd9c11fbbd1a3040456dfac3b34d94c66bcc65b03caf563adcc82e51036582194a3092319f0843305d5272d30e8e63ef65b6f57"} build_url:https://queue.taskcluster.net/v1/task/XsUnDtePTKytTQbE-xS2cw/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011377 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-Non-PGO/sha512/89094d025a1624ad33e6eac51323e1c7b92251842bc5c6145a48ecc656e7730f421a1fe1ec7d0f4a9750c4b37b4724c852c02ffc55c4268aa69483d9e75accea", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1fece8f4f8190f85fb1867575890bd2713eb8df7401630802f7798aa970507dba1676389fa8ab1e821953467788ab5505f6a9ecac5253218acc0f9e16e1a0863", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e83ed23057e64c6172359322fe25347a901fd4fad8c8aef11c4c21411c571a7fcf0cf4172d184f70e14a5dd0ddd7f6e438df7cdb4d9f9187d82d91fd457c29dd", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c354a7da37ef6e589d610d684cd9c11fbbd1a3040456dfac3b34d94c66bcc65b03caf563adcc82e51036582194a3092319f0843305d5272d30e8e63ef65b6f57"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-14 00:25:18.512894) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-14 00:25:18.513208) ========= 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=62c568580acbfdaac3eec7be000001dc-1505372454.848864-649808837 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004605 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-14 00:25:18.596635) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-14 00:25:18.596955) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-14 00:25:18.597289) ========= ========= Total master_lag: 0.23 =========