builder: mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s slave: talos-linux64-ix-077 starttime: 1505499866.46 results: success (0) revision: 9071a20f3eaa804a439990b7596dbc16d52d1e20 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-15 11:24:26.456230) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-15 11:24:26.456613) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-15 11:24:26.456913) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-15 11:24:26.583735) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-15 11:24:26.584037) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=20e20d796406ba5117c4a6f1000001ba-1505497411.419713-283184589 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-15 11:24: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.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 94.8M=0s 2017-09-15 11:24:26 (94.8 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.101282 ========= master_lag: 0.05 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-15 11:24:26.737111) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-15 11:24:26.737442) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=20e20d796406ba5117c4a6f1000001ba-1505497411.419713-283184589 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018534 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-15 11:24:26.810965) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 12 secs) (at 2017-09-15 11:24:26.811291) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 9071a20f3eaa804a439990b7596dbc16d52d1e20 --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 9071a20f3eaa804a439990b7596dbc16d52d1e20 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=20e20d796406ba5117c4a6f1000001ba-1505497411.419713-283184589 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-15 11:24:26,893 truncating revision to first 12 chars 2017-09-15 11:24:26,893 Setting DEBUG logging. 2017-09-15 11:24:26,893 attempt 1/10 2017-09-15 11:24:26,893 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/9071a20f3eaa?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-15 11:24:27,391 attempt 1/10 2017-09-15 11:24:27,961 current task status: no status available at this point. state: STARTED 2017-09-15 11:24:27,962 sleeping for 11.00s (attempt 1/10) 2017-09-15 11:24:38,973 attempt 2/10 2017-09-15 11:24:39,304 current task status: Task completed! Check 's3_urls' for upload locations. state: SUCCESS 2017-09-15 11:24:39,518 unpacking tar archive at: mozilla-central-9071a20f3eaa/testing/mozharness/ program finished with exit code 0 elapsedTime=12.969397 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 12 secs) (at 2017-09-15 11:24:39.809281) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-15 11:24:39.809588) ========= script_repo_revision: 9071a20f3eaa804a439990b7596dbc16d52d1e20 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-15 11:24:39.810012) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-15 11:24:39.810282) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-15 11:24:39.843366) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2017-09-15 11:24:39.843673) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-stylo-disabled-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-stylo-disabled-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=20e20d796406ba5117c4a6f1000001ba-1505497411.419713-283184589 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:24:40 INFO - MultiFileLogger online at 20170915 11:24:40 in /builds/slave/test 11:24:40 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-stylo-disabled-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 11:24:40 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:24:40 INFO - {'append_to_log': False, 11:24:40 INFO - 'base_work_dir': '/builds/slave/test', 11:24:40 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 11:24:40 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:24:40 INFO - 'branch': 'Firefox-Non-PGO', 11:24:40 INFO - 'buildbot_json_path': 'buildprops.json', 11:24:40 INFO - 'code_coverage': False, 11:24:40 INFO - 'config_files': ('talos/linux_config.py',), 11:24:40 INFO - 'default_actions': ('clobber', 11:24:40 INFO - 'read-buildbot-config', 11:24:40 INFO - 'download-and-extract', 11:24:40 INFO - 'populate-webroot', 11:24:40 INFO - 'create-virtualenv', 11:24:40 INFO - 'install', 11:24:40 INFO - 'setup-mitmproxy', 11:24:40 INFO - 'run-tests'), 11:24:40 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:24:40 INFO - 'disable_ccov_upload': False, 11:24:40 INFO - 'disable_stylo': False, 11:24:40 INFO - 'download_minidump_stackwalk': True, 11:24:40 INFO - 'download_symbols': 'ondemand', 11:24:40 INFO - 'enable_stylo': False, 11:24:40 INFO - 'enable_webrender': False, 11:24:40 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 11:24:40 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:24:40 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:24:40 INFO - 'gecko_profile': False, 11:24:40 INFO - 'gecko_profile_interval': 0, 11:24:40 INFO - 'installer_path': 'installer.exe', 11:24:40 INFO - 'log_level': 'info', 11:24:40 INFO - 'log_name': 'talos', 11:24:40 INFO - 'log_to_console': True, 11:24:40 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:24:40 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:24:40 INFO - 'opt_config_files': (), 11:24:40 INFO - 'pip_index': False, 11:24:40 INFO - 'suite': 'dromaeojs-stylo-disabled-e10s', 11:24:40 INFO - 'system_bits': '32', 11:24:40 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:24:40 INFO - 'title': 'talos-linux64-ix-077', 11:24:40 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:24:40 INFO - 'use_talos_json': True, 11:24:40 INFO - 'verify': 'False', 11:24:40 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:24:40 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:24:40 INFO - 'work_dir': 'build'} 11:24:40 INFO - [mozharness: 2017-09-15 18:24:40.058901Z] Running clobber step. 11:24:40 INFO - Running pre-action listener: _resource_record_pre_action 11:24:40 INFO - Running main action method: clobber 11:24:40 INFO - rmtree: /builds/slave/test/build 11:24:40 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:24:41 INFO - Running post-action listener: _resource_record_post_action 11:24:41 INFO - [mozharness: 2017-09-15 18:24:41.044342Z] Finished clobber step (success) 11:24:41 INFO - [mozharness: 2017-09-15 18:24:41.044439Z] Running read-buildbot-config step. 11:24:41 INFO - Running pre-action listener: _resource_record_pre_action 11:24:41 INFO - Running main action method: read_buildbot_config 11:24:41 INFO - Using buildbot properties: 11:24:41 INFO - { 11:24:41 INFO - "project": "", 11:24:41 INFO - "product": "firefox", 11:24:41 INFO - "who": "ffxbld@noreply.mozilla.org", 11:24:41 INFO - "installer_path": "public/build/target.tar.bz2", 11:24:41 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s", 11:24:41 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 11:24:41 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-stylo-disabled-e10s", 11:24:41 INFO - "stage_platform": "linux64", 11:24:41 INFO - "basedir": "/builds/slave/test", 11:24:41 INFO - "buildnumber": 25, 11:24:41 INFO - "platform": "ubuntu64_hw", 11:24:41 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 11:24:41 INFO - "slavebuilddir": "test", 11:24:41 INFO - "taskId": "Igy22YjuTOGgGzmJWa6hYg", 11:24:41 INFO - "branch": "mozilla-central", 11:24:41 INFO - "script_repo_revision": "production", 11:24:41 INFO - "revision": "9071a20f3eaa804a439990b7596dbc16d52d1e20", 11:24:41 INFO - "slavename": "talos-linux64-ix-077", 11:24:41 INFO - "repo_path": "mozilla-central" 11:24:41 INFO - } 11:24:41 INFO - Finding installer, test and symbols from parent task. 11:24:41 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Igy22YjuTOGgGzmJWa6hYg'}, attempt #1 11:24:41 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Igy22YjuTOGgGzmJWa6hYg'}, attempt #1 11:24:41 INFO - Task dependencies: dGTWU5R0RMmqQFwWXFslJA 11:24:41 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dGTWU5R0RMmqQFwWXFslJA'}, attempt #1 11:24:42 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/dGTWU5R0RMmqQFwWXFslJA/artifacts/public/build/target.tar.bz2 11:24:42 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/dGTWU5R0RMmqQFwWXFslJA/artifacts/public/build/target.test_packages.json 11:24:42 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/dGTWU5R0RMmqQFwWXFslJA/artifacts/public/build/target.crashreporter-symbols.zip 11:24:42 INFO - Running post-action listener: _resource_record_post_action 11:24:42 INFO - [mozharness: 2017-09-15 18:24:42.397211Z] Finished read-buildbot-config step (success) 11:24:42 INFO - [mozharness: 2017-09-15 18:24:42.397428Z] Running download-and-extract step. 11:24:42 INFO - Running pre-action listener: _resource_record_pre_action 11:24:42 INFO - Running main action method: download_and_extract 11:24:42 INFO - mkdir: /builds/slave/test/build/tests 11:24:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:24:42 INFO - trying https://queue.taskcluster.net/v1/task/dGTWU5R0RMmqQFwWXFslJA/artifacts/public/build/target.test_packages.json 11:24:42 INFO - Downloading https://queue.taskcluster.net/v1/task/dGTWU5R0RMmqQFwWXFslJA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 11:24:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dGTWU5R0RMmqQFwWXFslJA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 11:24:42 INFO - Downloaded 989 bytes. 11:24:42 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 11:24:42 INFO - Using the following test package requirements: 11:24:42 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 11:24:42 INFO - u'common': [u'target.common.tests.zip'], 11:24:42 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 11:24:42 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 11:24:42 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 11:24:42 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 11:24:42 INFO - u'mozbase': [u'target.common.tests.zip'], 11:24:42 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 11:24:42 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 11:24:42 INFO - u'web-platform': [u'target.common.tests.zip', 11:24:42 INFO - u'target.web-platform.tests.tar.gz'], 11:24:42 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 11:24:42 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 11:24:42 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/dGTWU5R0RMmqQFwWXFslJA/artifacts/public/build/target.common.tests.zip 11:24:42 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dGTWU5R0RMmqQFwWXFslJA/artifacts/public/build/target.common.tests.zip'}, attempt #1 11:24:42 INFO - Fetch https://queue.taskcluster.net/v1/task/dGTWU5R0RMmqQFwWXFslJA/artifacts/public/build/target.common.tests.zip into memory 11:24:44 INFO - Content-Length response header: 54736823 11:24:44 INFO - Bytes received: 54736823 11:24:55 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/dGTWU5R0RMmqQFwWXFslJA/artifacts/public/build/target.talos.tests.zip 11:24:55 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dGTWU5R0RMmqQFwWXFslJA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 11:24:55 INFO - Fetch https://queue.taskcluster.net/v1/task/dGTWU5R0RMmqQFwWXFslJA/artifacts/public/build/target.talos.tests.zip into memory 11:24:56 INFO - Content-Length response header: 14502661 11:24:56 INFO - Bytes received: 14502661 11:24:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:24:56 INFO - trying https://queue.taskcluster.net/v1/task/dGTWU5R0RMmqQFwWXFslJA/artifacts/public/build/target.tar.bz2 11:24:56 INFO - Downloading https://queue.taskcluster.net/v1/task/dGTWU5R0RMmqQFwWXFslJA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 11:24:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dGTWU5R0RMmqQFwWXFslJA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 11:24:57 INFO - Downloaded 61395675 bytes. 11:24:57 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/dGTWU5R0RMmqQFwWXFslJA/artifacts/public/build/target.tar.bz2 11:24:57 INFO - mkdir: /builds/slave/test/properties 11:24:57 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:24:57 INFO - Writing to file /builds/slave/test/properties/build_url 11:24:57 INFO - Contents: 11:24:57 INFO - build_url:https://queue.taskcluster.net/v1/task/dGTWU5R0RMmqQFwWXFslJA/artifacts/public/build/target.tar.bz2 11:24:57 INFO - Running post-action listener: _resource_record_post_action 11:24:57 INFO - Running post-action listener: find_tests_for_verification 11:24:57 INFO - Running post-action listener: set_extra_try_arguments 11:24:57 INFO - [mozharness: 2017-09-15 18:24:57.771128Z] Finished download-and-extract step (success) 11:24:57 INFO - [mozharness: 2017-09-15 18:24:57.771357Z] Running populate-webroot step. 11:24:57 INFO - Running pre-action listener: _resource_record_pre_action 11:24:57 INFO - Running main action method: populate_webroot 11:24:57 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:24:57 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:24:57 INFO - 'tests': ['tresize', 11:24:57 INFO - 'tcanvasmark']}, 11:24:57 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:24:57 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:24:57 INFO - 'tests': ['dromaeo_css', 11:24:57 INFO - 'kraken']}, 11:24:57 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 11:24:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:24:57 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:24:57 INFO - 'talos_options': ['--disable-stylo'], 11:24:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:24:57 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 11:24:57 INFO - 'tests': ['damp', 'tps']}, 11:24:57 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:24:57 INFO - 'talos_options': ['--disable-stylo'], 11:24:57 INFO - 'tests': ['damp', 'tps']}, 11:24:57 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:24:57 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:24:57 INFO - 'tests': ['dromaeo_dom']}, 11:24:57 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 11:24:57 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:24:57 INFO - 'tests': ['basic_compositor_video', 11:24:57 INFO - 'glvideo']}, 11:24:57 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 11:24:57 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 11:24:57 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:24:57 INFO - 'talos_options': ['--disable-stylo'], 11:24:57 INFO - 'tests': ['ts_paint_webext', 11:24:57 INFO - 'tp5o_webext']}, 11:24:57 INFO - 'other-e10s': {'tests': ['a11yr', 11:24:57 INFO - 'ts_paint', 11:24:57 INFO - 'tpaint', 11:24:57 INFO - 'sessionrestore', 11:24:57 INFO - 'sessionrestore_many_windows', 11:24:57 INFO - 'sessionrestore_no_auto_restore', 11:24:57 INFO - 'tabpaint']}, 11:24:57 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:24:57 INFO - 'tests': ['a11yr', 11:24:57 INFO - 'ts_paint', 11:24:57 INFO - 'tpaint', 11:24:57 INFO - 'sessionrestore', 11:24:57 INFO - 'sessionrestore_many_windows', 11:24:57 INFO - 'sessionrestore_no_auto_restore', 11:24:57 INFO - 'tabpaint']}, 11:24:57 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 11:24:57 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 11:24:57 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:24:57 INFO - 'tests': ['bloom_basic_singleton']}, 11:24:57 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:24:57 INFO - 'tests': ['bloom_basic']}, 11:24:57 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:24:57 INFO - 'tsvgr_opacity', 11:24:57 INFO - 'tart', 11:24:57 INFO - 'tscrollx', 11:24:57 INFO - 'tsvg_static']}, 11:24:57 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:24:57 INFO - 'tests': ['tsvgx', 11:24:57 INFO - 'tsvgr_opacity', 11:24:57 INFO - 'tart', 11:24:57 INFO - 'tscrollx', 11:24:57 INFO - 'tsvg_static']}, 11:24:57 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 11:24:57 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:24:57 INFO - 'talos_options': ['--disable-stylo'], 11:24:57 INFO - 'tests': ['tp5o']}, 11:24:57 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:24:57 INFO - 'talos_options': ['--mitmproxy', 11:24:57 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:24:57 INFO - '--firstNonBlankPaint'], 11:24:57 INFO - 'tests': ['tp6_google', 11:24:57 INFO - 'tp6_youtube', 11:24:57 INFO - 'tp6_amazon', 11:24:57 INFO - 'tp6_facebook']}, 11:24:57 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:24:57 INFO - 'talos_options': ['--disable-stylo', 11:24:57 INFO - '--mitmproxy', 11:24:57 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:24:57 INFO - '--firstNonBlankPaint'], 11:24:57 INFO - 'tests': ['tp6_google', 11:24:57 INFO - 'tp6_youtube', 11:24:57 INFO - 'tp6_amazon', 11:24:57 INFO - 'tp6_facebook']}, 11:24:57 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:24:57 INFO - 'talos_options': ['--stylo-threads=1', 11:24:57 INFO - '--mitmproxy', 11:24:57 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:24:57 INFO - '--firstNonBlankPaint'], 11:24:57 INFO - 'tests': ['tp6_google', 11:24:57 INFO - 'tp6_youtube', 11:24:57 INFO - 'tp6_amazon', 11:24:57 INFO - 'tp6_facebook']}, 11:24:57 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 11:24:57 INFO - 'talos_options': ['--xperf_path', 11:24:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:24:57 INFO - 'tests': ['tp5n']}, 11:24:57 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:24:57 INFO - 'talos_options': ['--disable-stylo', 11:24:57 INFO - '--xperf_path', 11:24:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:24:57 INFO - 'tests': ['tp5n']}}} 11:24:57 INFO - Running post-action listener: _resource_record_post_action 11:24:57 INFO - [mozharness: 2017-09-15 18:24:57.787902Z] Finished populate-webroot step (success) 11:24:57 INFO - [mozharness: 2017-09-15 18:24:57.787993Z] Running create-virtualenv step. 11:24:57 INFO - Running pre-action listener: _resource_record_pre_action 11:24:57 INFO - Running main action method: create_virtualenv 11:24:57 INFO - Creating virtualenv /builds/slave/test/build/venv 11:24:57 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 11:24:57 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 11:24:57 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 11:24:57 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:24:57 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:24:58 INFO - Installing distribute.............................................................................................................................................................................................done. 11:24:58 INFO - Installing pip...............done. 11:24:58 INFO - Return code: 0 11:24:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 11:24:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 11:24:58 INFO - Reading from file tmpfile_stdout 11:24:58 INFO - Output received: 11:24: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) 11:24:58 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:24: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')]} 11:24:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:24: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')]} 11:24:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:24: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 0x17e91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19b2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b55a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b59090>, '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 0x1b59d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b53f90>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '20e20d796406ba5117c4a6f1000001ba-1505497411.419713-283184589', '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 11:24: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 11:24: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 11:24:58 INFO - Using env: {'DISPLAY': ':0', 11:24:58 INFO - 'HOME': '/home/cltbld', 11:24:58 INFO - 'LANG': 'en_US.UTF-8', 11:24:58 INFO - 'LANGUAGE': 'en_US:en', 11:24:58 INFO - 'LOGNAME': 'cltbld', 11:24:58 INFO - 'MAIL': '/var/mail/cltbld', 11:24:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:24:58 INFO - 'MOZ_NO_REMOTE': '1', 11:24:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:24:58 INFO - 'NO_EM_RESTART': '1', 11:24:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:24:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:24:58 INFO - 'PWD': '/builds/slave/test', 11:24:58 INFO - 'SHELL': '/bin/bash', 11:24:58 INFO - 'SHLVL': '1', 11:24:58 INFO - 'TERM': 'linux', 11:24:58 INFO - 'TMOUT': '86400', 11:24:58 INFO - 'USER': 'cltbld', 11:24:58 INFO - 'XDG_SESSION_COOKIE': '20e20d796406ba5117c4a6f1000001ba-1505497411.419713-283184589', 11:24:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:24:58 INFO - '_': '/tools/buildbot/bin/python'} 11:25:00 INFO - Ignoring indexes: http://pypi.python.org/simple/ 11:25:00 INFO - Downloading/unpacking pip>=1.5 11:25:00 INFO - Running setup.py egg_info for package pip 11:25:00 INFO - warning: no files found matching 'pip/cacert.pem' 11:25:00 INFO - warning: no files found matching '*.html' under directory 'docs' 11:25:00 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 11:25:00 INFO - no previously-included directories found matching 'docs/_build/_sources' 11:25:00 INFO - Installing collected packages: pip 11:25:00 INFO - Found existing installation: pip 1.1 11:25:00 INFO - Uninstalling pip: 11:25:00 INFO - Successfully uninstalled pip 11:25:00 INFO - Running setup.py install for pip 11:25:00 INFO - warning: no files found matching 'pip/cacert.pem' 11:25:00 INFO - warning: no files found matching '*.html' under directory 'docs' 11:25:00 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 11:25:00 INFO - no previously-included directories found matching 'docs/_build/_sources' 11:25:00 INFO - Installing pip script to /builds/slave/test/build/venv/bin 11:25:00 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 11:25:00 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 11:25:00 INFO - Successfully installed pip 11:25:00 INFO - Cleaning up... 11:25:00 INFO - Return code: 0 11:25:00 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:25:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:25:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:25:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:25:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:25:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17e91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19b2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b55a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b59090>, '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 0x1b59d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b53f90>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '20e20d796406ba5117c4a6f1000001ba-1505497411.419713-283184589', '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 11:25:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 11:25:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 11:25:00 INFO - Using env: {'DISPLAY': ':0', 11:25:00 INFO - 'HOME': '/home/cltbld', 11:25:00 INFO - 'LANG': 'en_US.UTF-8', 11:25:00 INFO - 'LANGUAGE': 'en_US:en', 11:25:00 INFO - 'LOGNAME': 'cltbld', 11:25:00 INFO - 'MAIL': '/var/mail/cltbld', 11:25:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:25:00 INFO - 'MOZ_NO_REMOTE': '1', 11:25:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:25:00 INFO - 'NO_EM_RESTART': '1', 11:25:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:25:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:25:00 INFO - 'PWD': '/builds/slave/test', 11:25:00 INFO - 'SHELL': '/bin/bash', 11:25:00 INFO - 'SHLVL': '1', 11:25:00 INFO - 'TERM': 'linux', 11:25:00 INFO - 'TMOUT': '86400', 11:25:00 INFO - 'USER': 'cltbld', 11:25:00 INFO - 'XDG_SESSION_COOKIE': '20e20d796406ba5117c4a6f1000001ba-1505497411.419713-283184589', 11:25:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:25:00 INFO - '_': '/tools/buildbot/bin/python'} 11:25:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:25:00 INFO - Downloading/unpacking psutil>=3.1.1 11:25:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:25:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:25:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:25:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:25:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:25:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:25:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:25:01 INFO - Installing collected packages: psutil 11:25:01 INFO - Running setup.py install for psutil 11:25:01 INFO - building 'psutil._psutil_linux' extension 11:25: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 11:25: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 11:25:01 INFO - building 'psutil._psutil_posix' extension 11:25: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 11:25: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 11:25:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:25:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:25:02 INFO - Successfully installed psutil 11:25:02 INFO - Cleaning up... 11:25:02 INFO - Return code: 0 11:25:02 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:25:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:25:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:25:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:25:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:25:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17e91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19b2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b55a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b59090>, '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 0x1b59d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b53f90>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '20e20d796406ba5117c4a6f1000001ba-1505497411.419713-283184589', '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 11:25:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 11:25:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 11:25:02 INFO - Using env: {'DISPLAY': ':0', 11:25:02 INFO - 'HOME': '/home/cltbld', 11:25:02 INFO - 'LANG': 'en_US.UTF-8', 11:25:02 INFO - 'LANGUAGE': 'en_US:en', 11:25:02 INFO - 'LOGNAME': 'cltbld', 11:25:02 INFO - 'MAIL': '/var/mail/cltbld', 11:25:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:25:02 INFO - 'MOZ_NO_REMOTE': '1', 11:25:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:25:02 INFO - 'NO_EM_RESTART': '1', 11:25:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:25:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:25:02 INFO - 'PWD': '/builds/slave/test', 11:25:02 INFO - 'SHELL': '/bin/bash', 11:25:02 INFO - 'SHLVL': '1', 11:25:02 INFO - 'TERM': 'linux', 11:25:02 INFO - 'TMOUT': '86400', 11:25:02 INFO - 'USER': 'cltbld', 11:25:02 INFO - 'XDG_SESSION_COOKIE': '20e20d796406ba5117c4a6f1000001ba-1505497411.419713-283184589', 11:25:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:25:02 INFO - '_': '/tools/buildbot/bin/python'} 11:25:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:25:02 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:25:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:25:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:25:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:25:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:25:03 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:25:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:25:03 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:25:03 INFO - Installing collected packages: mozsystemmonitor 11:25:03 INFO - Running setup.py install for mozsystemmonitor 11:25:03 INFO - Successfully installed mozsystemmonitor 11:25:03 INFO - Cleaning up... 11:25:03 INFO - Return code: 0 11:25:03 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:25:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:25:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:25:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:25:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:25:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17e91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19b2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b55a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b59090>, '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 0x1b59d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b53f90>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '20e20d796406ba5117c4a6f1000001ba-1505497411.419713-283184589', '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 11:25:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 11:25:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 11:25:03 INFO - Using env: {'DISPLAY': ':0', 11:25:03 INFO - 'HOME': '/home/cltbld', 11:25:03 INFO - 'LANG': 'en_US.UTF-8', 11:25:03 INFO - 'LANGUAGE': 'en_US:en', 11:25:03 INFO - 'LOGNAME': 'cltbld', 11:25:03 INFO - 'MAIL': '/var/mail/cltbld', 11:25:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:25:03 INFO - 'MOZ_NO_REMOTE': '1', 11:25:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:25:03 INFO - 'NO_EM_RESTART': '1', 11:25:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:25:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:25:03 INFO - 'PWD': '/builds/slave/test', 11:25:03 INFO - 'SHELL': '/bin/bash', 11:25:03 INFO - 'SHLVL': '1', 11:25:03 INFO - 'TERM': 'linux', 11:25:03 INFO - 'TMOUT': '86400', 11:25:03 INFO - 'USER': 'cltbld', 11:25:03 INFO - 'XDG_SESSION_COOKIE': '20e20d796406ba5117c4a6f1000001ba-1505497411.419713-283184589', 11:25:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:25:03 INFO - '_': '/tools/buildbot/bin/python'} 11:25:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:25:03 INFO - Downloading/unpacking jsonschema==2.5.1 11:25:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:25:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:25:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:25:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:25:04 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:25:04 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:25: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 11:25: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 11:25: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 11:25: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 11:25:05 INFO - Downloading functools32-3.2.3-2.tar.gz 11:25:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:25:05 INFO - warning: no files found matching '*.txt' 11:25:05 INFO - no previously-included directories found matching 'build' 11:25:05 INFO - no previously-included directories found matching 'dist' 11:25:05 INFO - no previously-included directories found matching '.git*' 11:25:05 INFO - Installing collected packages: jsonschema, functools32 11:25:05 INFO - Running setup.py install for functools32 11:25:05 INFO - warning: no files found matching '*.txt' 11:25:05 INFO - no previously-included directories found matching 'build' 11:25:05 INFO - no previously-included directories found matching 'dist' 11:25:05 INFO - no previously-included directories found matching '.git*' 11:25:05 INFO - Successfully installed jsonschema functools32 11:25:05 INFO - Cleaning up... 11:25:05 INFO - Return code: 0 11:25:05 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 11:25:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:25:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:25:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:25:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:25:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17e91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19b2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b55a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b59090>, '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 0x1b59d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b53f90>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '20e20d796406ba5117c4a6f1000001ba-1505497411.419713-283184589', '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 11:25:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 11:25:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 11:25:05 INFO - Using env: {'DISPLAY': ':0', 11:25:05 INFO - 'HOME': '/home/cltbld', 11:25:05 INFO - 'LANG': 'en_US.UTF-8', 11:25:05 INFO - 'LANGUAGE': 'en_US:en', 11:25:05 INFO - 'LOGNAME': 'cltbld', 11:25:05 INFO - 'MAIL': '/var/mail/cltbld', 11:25:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:25:05 INFO - 'MOZ_NO_REMOTE': '1', 11:25:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:25:05 INFO - 'NO_EM_RESTART': '1', 11:25:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:25:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:25:05 INFO - 'PWD': '/builds/slave/test', 11:25:05 INFO - 'SHELL': '/bin/bash', 11:25:05 INFO - 'SHLVL': '1', 11:25:05 INFO - 'TERM': 'linux', 11:25:05 INFO - 'TMOUT': '86400', 11:25:05 INFO - 'USER': 'cltbld', 11:25:05 INFO - 'XDG_SESSION_COOKIE': '20e20d796406ba5117c4a6f1000001ba-1505497411.419713-283184589', 11:25:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:25:05 INFO - '_': '/tools/buildbot/bin/python'} 11:25:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:25:05 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 11:25:05 INFO - Cleaning up... 11:25:05 INFO - Return code: 0 11:25:05 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:25:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:25:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:25:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:25:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:25:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17e91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19b2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b55a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b59090>, '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 0x1b59d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b53f90>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '20e20d796406ba5117c4a6f1000001ba-1505497411.419713-283184589', '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 11:25:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 11:25:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 11:25:05 INFO - Using env: {'DISPLAY': ':0', 11:25:05 INFO - 'HOME': '/home/cltbld', 11:25:05 INFO - 'LANG': 'en_US.UTF-8', 11:25:05 INFO - 'LANGUAGE': 'en_US:en', 11:25:05 INFO - 'LOGNAME': 'cltbld', 11:25:05 INFO - 'MAIL': '/var/mail/cltbld', 11:25:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:25:05 INFO - 'MOZ_NO_REMOTE': '1', 11:25:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:25:05 INFO - 'NO_EM_RESTART': '1', 11:25:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:25:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:25:05 INFO - 'PWD': '/builds/slave/test', 11:25:05 INFO - 'SHELL': '/bin/bash', 11:25:05 INFO - 'SHLVL': '1', 11:25:05 INFO - 'TERM': 'linux', 11:25:05 INFO - 'TMOUT': '86400', 11:25:05 INFO - 'USER': 'cltbld', 11:25:05 INFO - 'XDG_SESSION_COOKIE': '20e20d796406ba5117c4a6f1000001ba-1505497411.419713-283184589', 11:25:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:25:05 INFO - '_': '/tools/buildbot/bin/python'} 11:25:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:25:05 INFO - Downloading/unpacking blobuploader==1.2.4 11:25:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:25:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:25:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:25:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:25:06 INFO - Downloading blobuploader-1.2.4.tar.gz 11:25:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:25:06 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:25: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 11:25: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 11:25: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 11:25: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 11:25:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:25:07 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:25:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:25:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:25:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:25:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:25:07 INFO - Downloading docopt-0.6.1.tar.gz 11:25:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:25:07 INFO - Installing collected packages: blobuploader, requests, docopt 11:25:07 INFO - Running setup.py install for blobuploader 11:25:07 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:25:07 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:25:07 INFO - Running setup.py install for requests 11:25:07 INFO - Running setup.py install for docopt 11:25:08 INFO - Successfully installed blobuploader requests docopt 11:25:08 INFO - Cleaning up... 11:25:08 INFO - Return code: 0 11:25:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:25:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:25:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:25:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:25:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:25:08 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 0x17e91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19b2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b55a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b59090>, '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 0x1b59d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b53f90>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '20e20d796406ba5117c4a6f1000001ba-1505497411.419713-283184589', '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 11:25:08 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 11:25:08 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 11:25:08 INFO - Using env: {'DISPLAY': ':0', 11:25:08 INFO - 'HOME': '/home/cltbld', 11:25:08 INFO - 'LANG': 'en_US.UTF-8', 11:25:08 INFO - 'LANGUAGE': 'en_US:en', 11:25:08 INFO - 'LOGNAME': 'cltbld', 11:25:08 INFO - 'MAIL': '/var/mail/cltbld', 11:25:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:25:08 INFO - 'MOZ_NO_REMOTE': '1', 11:25:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:25:08 INFO - 'NO_EM_RESTART': '1', 11:25:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:25:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:25:08 INFO - 'PWD': '/builds/slave/test', 11:25:08 INFO - 'SHELL': '/bin/bash', 11:25:08 INFO - 'SHLVL': '1', 11:25:08 INFO - 'TERM': 'linux', 11:25:08 INFO - 'TMOUT': '86400', 11:25:08 INFO - 'USER': 'cltbld', 11:25:08 INFO - 'XDG_SESSION_COOKIE': '20e20d796406ba5117c4a6f1000001ba-1505497411.419713-283184589', 11:25:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:25:08 INFO - '_': '/tools/buildbot/bin/python'} 11:25:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:25:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:25:08 INFO - Running setup.py (path:/tmp/pip-wmXva9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:25:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:25:08 INFO - Running setup.py (path:/tmp/pip-Bi02Nq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:25:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:25:08 INFO - Running setup.py (path:/tmp/pip-NNAcQ7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:25:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:25:08 INFO - Running setup.py (path:/tmp/pip-nTgUBu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:25:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:25:08 INFO - Running setup.py (path:/tmp/pip-f4EbBI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:25:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:25:08 INFO - Running setup.py (path:/tmp/pip-_6QS0_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:25:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:25:08 INFO - Running setup.py (path:/tmp/pip-pawl8A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:25:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:25:08 INFO - Running setup.py (path:/tmp/pip-hkS41B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:25:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:25:08 INFO - Running setup.py (path:/tmp/pip-ydul05-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:25:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:25:08 INFO - Running setup.py (path:/tmp/pip-gwBRzV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:25:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:25:08 INFO - Running setup.py (path:/tmp/pip-XkJ5eI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:25:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:25:09 INFO - Running setup.py (path:/tmp/pip-8p_jC5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:25:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:25:09 INFO - Running setup.py (path:/tmp/pip-X8oqdV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:25:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:25:09 INFO - Running setup.py (path:/tmp/pip-siO4m4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:25:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:25:09 INFO - Running setup.py (path:/tmp/pip-qspKY9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:25:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:25:09 INFO - Running setup.py (path:/tmp/pip-3geMtq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:25:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:25:09 INFO - Running setup.py (path:/tmp/pip-LhrSyf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:25:09 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:25:09 INFO - Running setup.py install for manifestparser 11:25:09 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:25:09 INFO - Running setup.py install for mozcrash 11:25:09 INFO - Running setup.py install for mozdebug 11:25:09 INFO - Running setup.py install for mozdevice 11:25:09 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:25:09 INFO - Running setup.py install for mozfile 11:25:09 INFO - Running setup.py install for mozhttpd 11:25:10 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:25:10 INFO - Running setup.py install for mozinfo 11:25:10 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:25:10 INFO - Running setup.py install for mozInstall 11:25:10 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:25:10 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:25:10 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:25:10 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:25:10 INFO - Running setup.py install for mozleak 11:25:10 INFO - Running setup.py install for mozlog 11:25:10 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:25:10 INFO - Running setup.py install for moznetwork 11:25:10 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:25:10 INFO - Running setup.py install for mozprocess 11:25:10 INFO - Running setup.py install for mozprofile 11:25:10 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:25:10 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:25:10 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:25:10 INFO - Running setup.py install for mozrunner 11:25:10 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:25:10 INFO - Running setup.py install for mozscreenshot 11:25:11 INFO - Running setup.py install for moztest 11:25:11 INFO - Running setup.py install for mozversion 11:25:11 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:25:11 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:25:11 INFO - Cleaning up... 11:25:11 INFO - Return code: 0 11:25:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:25:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:25:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:25:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:25:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:25:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17e91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19b2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b55a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b59090>, '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 0x1b59d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b53f90>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '20e20d796406ba5117c4a6f1000001ba-1505497411.419713-283184589', '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 11:25:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 11:25:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:25:11 INFO - Using env: {'DISPLAY': ':0', 11:25:11 INFO - 'HOME': '/home/cltbld', 11:25:11 INFO - 'LANG': 'en_US.UTF-8', 11:25:11 INFO - 'LANGUAGE': 'en_US:en', 11:25:11 INFO - 'LOGNAME': 'cltbld', 11:25:11 INFO - 'MAIL': '/var/mail/cltbld', 11:25:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:25:11 INFO - 'MOZ_NO_REMOTE': '1', 11:25:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:25:11 INFO - 'NO_EM_RESTART': '1', 11:25:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:25:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:25:11 INFO - 'PWD': '/builds/slave/test', 11:25:11 INFO - 'SHELL': '/bin/bash', 11:25:11 INFO - 'SHLVL': '1', 11:25:11 INFO - 'TERM': 'linux', 11:25:11 INFO - 'TMOUT': '86400', 11:25:11 INFO - 'USER': 'cltbld', 11:25:11 INFO - 'XDG_SESSION_COOKIE': '20e20d796406ba5117c4a6f1000001ba-1505497411.419713-283184589', 11:25:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:25:11 INFO - '_': '/tools/buildbot/bin/python'} 11:25:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:25:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:25:11 INFO - Running setup.py (path:/tmp/pip-4RIcaj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:25:11 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 11:25:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:25:11 INFO - Running setup.py (path:/tmp/pip-j801uE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:25:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:25:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:25:11 INFO - Running setup.py (path:/tmp/pip-qvQ7dn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:25:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 11:25:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:25:11 INFO - Running setup.py (path:/tmp/pip-hC5ny_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:25:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.51 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:25:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:25:11 INFO - Running setup.py (path:/tmp/pip-1togo1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:25:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 11:25:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:25:11 INFO - Running setup.py (path:/tmp/pip-a0qi7x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:25:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 11:25:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:25:11 INFO - Running setup.py (path:/tmp/pip-m2RsoL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:25:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.10 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 11:25:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:25:11 INFO - Running setup.py (path:/tmp/pip-mO9cS6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:25:12 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)) 11:25:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:25:12 INFO - Running setup.py (path:/tmp/pip-LmEFgy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:25:12 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)) 11:25:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:25:12 INFO - Running setup.py (path:/tmp/pip-NGQcjP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:25:12 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)) 11:25:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:25:12 INFO - Running setup.py (path:/tmp/pip-Mf1Y9p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:25:12 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 11:25:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:25:12 INFO - Running setup.py (path:/tmp/pip-brO06W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:25:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 11:25:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:25:12 INFO - Running setup.py (path:/tmp/pip-MhtzSi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:25:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 11:25:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:25:12 INFO - Running setup.py (path:/tmp/pip-hoSDuL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:25:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 11:25:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:25:12 INFO - Running setup.py (path:/tmp/pip-EEYB50-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:25:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 11:25:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:25:12 INFO - Running setup.py (path:/tmp/pip-HlUOqN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:25:12 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 11:25:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:25:12 INFO - Running setup.py (path:/tmp/pip-83GyEQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:25:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 11:25:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:25:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:25:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 11:25:12 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:25:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:25:12 INFO - Requirement already satisfied (use --upgrade to upgrade): requests in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozInstall==1.13->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 11:25:12 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:25:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:25:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:25:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:25:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:25:13 INFO - Downloading blessings-1.6.tar.gz 11:25:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:25:13 INFO - Installing collected packages: blessings 11:25:13 INFO - Running setup.py install for blessings 11:25:13 INFO - Successfully installed blessings 11:25:13 INFO - Cleaning up... 11:25:14 INFO - Return code: 0 11:25:14 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:25:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:25:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:25:14 INFO - Reading from file tmpfile_stdout 11:25:14 INFO - Current package versions: 11:25:14 INFO - argparse == 1.2.1 11:25:14 INFO - blessings == 1.6 11:25:14 INFO - blobuploader == 1.2.4 11:25:14 INFO - docopt == 0.6.1 11:25:14 INFO - functools32 == 3.2.3-2 11:25:14 INFO - jsonschema == 2.5.1 11:25:14 INFO - manifestparser == 1.1 11:25:14 INFO - mozInstall == 1.13 11:25:14 INFO - mozcrash == 1.0 11:25:14 INFO - mozdebug == 0.1 11:25:14 INFO - mozdevice == 0.51 11:25:14 INFO - mozfile == 1.2 11:25:14 INFO - mozhttpd == 0.7 11:25:14 INFO - mozinfo == 0.10 11:25:14 INFO - mozleak == 0.1 11:25:14 INFO - mozlog == 3.5 11:25:14 INFO - moznetwork == 0.27 11:25:14 INFO - mozprocess == 0.25 11:25:14 INFO - mozprofile == 0.28 11:25:14 INFO - mozrunner == 6.13 11:25:14 INFO - mozscreenshot == 0.1 11:25:14 INFO - mozsystemmonitor == 0.3 11:25:14 INFO - moztest == 0.8 11:25:14 INFO - mozversion == 1.4 11:25:14 INFO - psutil == 3.1.1 11:25:14 INFO - requests == 1.2.3 11:25:14 INFO - wsgiref == 0.1.2 11:25:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:25:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:25:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:25:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:25:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:25:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17e91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19b2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b55a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b59090>, '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 0x1b59d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b53f90>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '20e20d796406ba5117c4a6f1000001ba-1505497411.419713-283184589', '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 11:25:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 11:25:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:25:14 INFO - Using env: {'DISPLAY': ':0', 11:25:14 INFO - 'HOME': '/home/cltbld', 11:25:14 INFO - 'LANG': 'en_US.UTF-8', 11:25:14 INFO - 'LANGUAGE': 'en_US:en', 11:25:14 INFO - 'LOGNAME': 'cltbld', 11:25:14 INFO - 'MAIL': '/var/mail/cltbld', 11:25:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:25:14 INFO - 'MOZ_NO_REMOTE': '1', 11:25:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:25:14 INFO - 'NO_EM_RESTART': '1', 11:25:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:25:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:25:14 INFO - 'PWD': '/builds/slave/test', 11:25:14 INFO - 'SHELL': '/bin/bash', 11:25:14 INFO - 'SHLVL': '1', 11:25:14 INFO - 'TERM': 'linux', 11:25:14 INFO - 'TMOUT': '86400', 11:25:14 INFO - 'USER': 'cltbld', 11:25:14 INFO - 'XDG_SESSION_COOKIE': '20e20d796406ba5117c4a6f1000001ba-1505497411.419713-283184589', 11:25:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:25:14 INFO - '_': '/tools/buildbot/bin/python'} 11:25:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:25:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 11:25:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 11:25:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 11:25:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 11:25:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 11:25:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 11:25:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 11:25:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 11:25:14 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 11:25:14 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 11:25:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:25:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:25:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:25:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:25:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 11:25:15 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 11:25:15 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 11:25:15 INFO - Installing collected packages: simplejson 11:25:15 INFO - Running setup.py install for simplejson 11:25:15 INFO - building 'simplejson._speedups' extension 11:25:15 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c simplejson/_speedups.c -o build/temp.linux-x86_64-2.7/simplejson/_speedups.o 11:25:16 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/simplejson/_speedups.o -o build/lib.linux-x86_64-2.7/simplejson/_speedups.so 11:25:16 INFO - Successfully installed simplejson 11:25:16 INFO - Cleaning up... 11:25:16 INFO - Return code: 0 11:25:16 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:25:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:25:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:25:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:25:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:25:16 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17e91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19b2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b55a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b59090>, '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 0x1b59d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b53f90>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '20e20d796406ba5117c4a6f1000001ba-1505497411.419713-283184589', '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 11:25:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 11:25:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 11:25:16 INFO - Using env: {'DISPLAY': ':0', 11:25:16 INFO - 'HOME': '/home/cltbld', 11:25:16 INFO - 'LANG': 'en_US.UTF-8', 11:25:16 INFO - 'LANGUAGE': 'en_US:en', 11:25:16 INFO - 'LOGNAME': 'cltbld', 11:25:16 INFO - 'MAIL': '/var/mail/cltbld', 11:25:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:25:16 INFO - 'MOZ_NO_REMOTE': '1', 11:25:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:25:16 INFO - 'NO_EM_RESTART': '1', 11:25:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:25:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:25:16 INFO - 'PWD': '/builds/slave/test', 11:25:16 INFO - 'SHELL': '/bin/bash', 11:25:16 INFO - 'SHLVL': '1', 11:25:16 INFO - 'TERM': 'linux', 11:25:16 INFO - 'TMOUT': '86400', 11:25:16 INFO - 'USER': 'cltbld', 11:25:16 INFO - 'XDG_SESSION_COOKIE': '20e20d796406ba5117c4a6f1000001ba-1505497411.419713-283184589', 11:25:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:25:16 INFO - '_': '/tools/buildbot/bin/python'} 11:25:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:25:16 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:25:16 INFO - Cleaning up... 11:25:16 INFO - Return code: 0 11:25:16 INFO - Running post-action listener: _resource_record_post_action 11:25:16 INFO - Running post-action listener: _start_resource_monitoring 11:25:16 INFO - Starting resource monitoring. 11:25:16 INFO - [mozharness: 2017-09-15 18:25:16.926772Z] Finished create-virtualenv step (success) 11:25:16 INFO - [mozharness: 2017-09-15 18:25:16.927240Z] Running install step. 11:25:16 INFO - Running pre-action listener: _resource_record_pre_action 11:25:16 INFO - Running main action method: install 11:25:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:25:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:25:17 INFO - Reading from file tmpfile_stdout 11:25:17 INFO - Detecting whether we're running mozinstall >=1.0... 11:25:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:25:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:25:17 INFO - Reading from file tmpfile_stdout 11:25:17 INFO - Output received: 11:25:17 INFO - Usage: mozinstall [options] installer 11:25:17 INFO - Options: 11:25:17 INFO - -h, --help show this help message and exit 11:25:17 INFO - -d DEST, --destination=DEST 11:25:17 INFO - Directory to install application into. [default: 11:25:17 INFO - "/builds/slave/test"] 11:25:17 INFO - --app=APP Application being installed. [default: firefox] 11:25:17 INFO - mkdir: /builds/slave/test/build/application 11:25:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 11:25:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 11:25:35 INFO - Reading from file tmpfile_stdout 11:25:35 INFO - Output received: 11:25:35 INFO - /builds/slave/test/build/application/firefox/firefox 11:25:35 INFO - Running post-action listener: _resource_record_post_action 11:25:35 INFO - [mozharness: 2017-09-15 18:25:35.014010Z] Finished install step (success) 11:25:35 INFO - [mozharness: 2017-09-15 18:25:35.014263Z] Running setup-mitmproxy step. 11:25:35 INFO - Running pre-action listener: _resource_record_pre_action 11:25:35 INFO - Running main action method: setup_mitmproxy 11:25:35 INFO - Skipping: mitmproxy is not required 11:25:35 INFO - Running post-action listener: _resource_record_post_action 11:25:35 INFO - [mozharness: 2017-09-15 18:25:35.015394Z] Finished setup-mitmproxy step (success) 11:25:35 INFO - [mozharness: 2017-09-15 18:25:35.015616Z] Running run-tests step. 11:25:35 INFO - Running pre-action listener: _resource_record_pre_action 11:25:35 INFO - Running pre-action listener: _set_gcov_prefix 11:25:35 INFO - Running main action method: run_tests 11:25:35 WARNING - Try message not found. 11:25:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:25:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:25:35 INFO - Python 2.7.3 11:25:35 INFO - Return code: 0 11:25:35 INFO - grabbing minidump binary from tooltool 11:25:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:25:35 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b59090>, '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 0x1b59d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b53f90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:25:35 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 11:25:35 INFO - Copy/paste: /tools/tooltool.py --url https://tooltool.mozilla-releng.net/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 11:25:35 INFO - Calling ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 11:25:35 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:25:35 INFO - Return code: 0 11:25:35 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:25:35 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:25:35 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:25:35 INFO - ENV: RUST_BACKTRACE is now full 11:25:35 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:25:35 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:25:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-stylo-disabled-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/dGTWU5R0RMmqQFwWXFslJA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-077', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log'] in /builds/slave/test/build 11:25:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-stylo-disabled-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/dGTWU5R0RMmqQFwWXFslJA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-077 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log 11:25:35 INFO - Using env: {'DISPLAY': ':0', 11:25:35 INFO - 'HOME': '/home/cltbld', 11:25:35 INFO - 'LANG': 'en_US.UTF-8', 11:25:35 INFO - 'LANGUAGE': 'en_US:en', 11:25:35 INFO - 'LOGNAME': 'cltbld', 11:25:35 INFO - 'MAIL': '/var/mail/cltbld', 11:25:35 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:25:35 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:25:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:25:35 INFO - 'MOZ_NO_REMOTE': '1', 11:25:35 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:25:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:25:35 INFO - 'NO_EM_RESTART': '1', 11:25:35 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:25:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:25:35 INFO - 'PWD': '/builds/slave/test', 11:25:35 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:25:35 INFO - 'RUST_BACKTRACE': 'full', 11:25:35 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 11:25:35 INFO - 'SHELL': '/bin/bash', 11:25:35 INFO - 'SHLVL': '1', 11:25:35 INFO - 'TERM': 'linux', 11:25:35 INFO - 'TMOUT': '86400', 11:25:35 INFO - 'USER': 'cltbld', 11:25:35 INFO - 'XDG_SESSION_COOKIE': '20e20d796406ba5117c4a6f1000001ba-1505497411.419713-283184589', 11:25:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:25:35 INFO - '_': '/tools/buildbot/bin/python'} 11:25:35 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-stylo-disabled-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/dGTWU5R0RMmqQFwWXFslJA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-077', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log'] with output_timeout 3600 11:25:35 INFO - mozversion application_buildid: 20170915173306 11:25:35 INFO - mozversion application_changeset: 9071a20f3eaa804a439990b7596dbc16d52d1e20 11:25:35 INFO - mozversion application_display_name: Nightly 11:25:35 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:25:35 INFO - mozversion application_name: Firefox 11:25:35 INFO - mozversion application_remotingname: firefox 11:25:35 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 11:25:35 INFO - mozversion application_vendor: Mozilla 11:25:35 INFO - mozversion application_version: 57.0a1 11:25:35 INFO - mozversion platform_buildid: 20170915173306 11:25:35 INFO - mozversion platform_changeset: 9071a20f3eaa804a439990b7596dbc16d52d1e20 11:25:35 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 11:25:35 INFO - mozversion platform_version: 57.0a1 11:25:35 INFO - using testdate: 1505499935 11:25:35 INFO - actual date: 1505499935 11:25:35 INFO - starting webserver on 'localhost:59109' 11:25:35 INFO - SUITE-START | Running 2 tests 11:25:35 INFO - TEST-START | dromaeo_css 11:25:35 INFO - Initialising browser for dromaeo_css test... 11:25:35 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:59109/getInfo.html -profile /tmp/tmp2Sl_GY/profile 11:25:35 INFO - TEST-INFO | started process 9445 (/builds/slave/test/build/application/firefox/firefox http://localhost:59109/getInfo.html) 11:25:40 INFO - TEST-INFO | 9445: exit 0 11:25:40 INFO - Browser initialized. 11:25:40 INFO - Running cycle 1/1 for dromaeo_css test... 11:25:40 INFO - Using env: {'DISPLAY': ':0', 11:25:40 INFO - 'HOME': '/home/cltbld', 11:25:40 INFO - 'JSGC_DISABLE_POISONING': '1', 11:25:40 INFO - 'LANG': 'en_US.UTF-8', 11:25:40 INFO - 'LANGUAGE': 'en_US:en', 11:25:40 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 11:25:40 INFO - 'LOGNAME': 'cltbld', 11:25:40 INFO - 'MAIL': '/var/mail/cltbld', 11:25:40 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:25:40 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:25:40 INFO - 'MOZ_CRASHREPORTER': '1', 11:25:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:25:40 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 11:25:40 INFO - 'MOZ_NO_REMOTE': '1', 11:25:40 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:25:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:25:40 INFO - 'NO_EM_RESTART': '1', 11:25:40 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:25:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:25:40 INFO - 'PWD': '/builds/slave/test', 11:25:40 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:25:40 INFO - 'RUST_BACKTRACE': 'full', 11:25:40 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 11:25:40 INFO - 'SHELL': '/bin/bash', 11:25:40 INFO - 'SHLVL': '1', 11:25:40 INFO - 'STYLO_FORCE_DISABLED': '1', 11:25:40 INFO - 'TERM': 'linux', 11:25:40 INFO - 'TMOUT': '86400', 11:25:40 INFO - 'USER': 'cltbld', 11:25:40 INFO - 'XDG_SESSION_COOKIE': '20e20d796406ba5117c4a6f1000001ba-1505497411.419713-283184589', 11:25:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:25:40 INFO - '_': '/tools/buildbot/bin/python'} 11:25:40 INFO - TEST-INFO | started process 9674 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp2Sl_GY/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 11:25:41 INFO - PID 9674 | 11:25:41 INFO - PID 9674 | (/builds/slave/test/build/application/firefox/firefox:9722): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 11:25:41 INFO - PID 9674 | 11:25:52 INFO - PID 9674 | RSS: Main: 173326336 11:25:52 INFO - PID 9674 | 11:28:50 INFO - PID 9674 | Cycle 1(1): loaded http://localhost:59109/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59109/tests/dromaeo/cssquery-ext.html) 11:28:50 INFO - PID 9674 | RSS: Main: 175882240 11:28:50 INFO - PID 9674 | 11:31:52 INFO - PID 9674 | Cycle 1(1): loaded http://localhost:59109/tests/dromaeo/cssquery-ext.html (next: http://localhost:59109/tests/dromaeo/cssquery-jquery.html) 11:31:53 INFO - PID 9674 | RSS: Main: 171454464 11:31:53 INFO - PID 9674 | 11:34:55 INFO - PID 9674 | Cycle 1(1): loaded http://localhost:59109/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59109/tests/dromaeo/cssquery-mootools.html) 11:34:55 INFO - PID 9674 | RSS: Main: 174268416 11:34:55 INFO - PID 9674 | 11:37:57 INFO - PID 9674 | Cycle 1(1): loaded http://localhost:59109/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59109/tests/dromaeo/cssquery-prototype.html) 11:37:57 INFO - PID 9674 | RSS: Main: 172838912 11:37:57 INFO - PID 9674 | 11:41:01 INFO - PID 9674 | Cycle 1(1): loaded http://localhost:59109/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59109/tests/dromaeo/cssquery-yui.html) 11:41:01 INFO - PID 9674 | RSS: Main: 174526464 11:41:01 INFO - PID 9674 | 11:44:03 INFO - PID 9674 | Cycle 1(1): loaded http://localhost:59109/tests/dromaeo/cssquery-yui.html (next: http://localhost:59109/tests/dromaeo/cssquery-dojo.html) 11:44:03 INFO - PID 9674 | RSS: Main: 175972352 11:44:03 INFO - PID 9674 | 11:44:03 INFO - PID 9674 | __start_tp_report 11:44:03 INFO - PID 9674 | _x_x_mozilla_page_load 11:44:03 INFO - PID 9674 | _x_x_mozilla_page_load_details 11:44:03 INFO - PID 9674 | |i|pagename|runs| 11:44:03 INFO - PID 9674 | |0;dojo.html;3162.367526494701;3165.7467402607795;3176.7140957313836;3184.188032051828;3190.6968837960417;6111.480524155441;6246.687665616712;6278.2779980302275;6302.369763023696;6366.2360516738;6210.441060304572;6249.9062514062325;6255.59338642989;6277.309495955453;6285.465735412484;5745.4829065384;5749.511291540224;5762;5785.82642520725;5799.18811366409;5780.277465316835;5786.913196302038;5802.100674395476;5821;5861.0915308127305;5788.247527821377;5820.796272130477;5822.359540450547;5843.2695913010875;5860.853478663025;5557.944420555783;5830.591858569902;5883.058710606304;5908.67502287374;5915.763369465216;5624.437556244384;5641.774329026875;5674.2623458950075;5727.4845263926445;5790.392008839053;6323.114763933053;6340.112384266206;6392.041193820917;6414.358564143595;6423.100765892778;6604.570702904296;6709.36261055199;6709.832254193635;6768.6615669216835;6823.351781580792;6816.182058153004;6852.725890964355;6855.725770969155;6858.897116543206;6872.175338959307;6250.249970003583;6316.147320111772;6354;6366.267879193906;6366.331535188831;6963.373296403348;6981.0924579804305;7024.367806897404;7055.329743674342;7061.152661680631;6451.258105317855;6583.670816459254;6619.900701489481;6630.370114839179;6719.0593316935665;6749.156355455568;6807.727690892309;6837;6838.589684618939;6839.863202735917;6777.559458635173;6793.388595026471;6802.65986700663;6802.761903333359;6830.965845170742;6696.665166741644;6773.288804675537;6776.322367763184;6778.966105169443;6784.321567843275;5280.841574752687;5285.656432331886;5347.545458636059;5379.273798037293;5380.085385484477;4558.475775285885;4580.587747102777;4609.078184363141;4659.068186362741;4683.6721429500285;5813.09896965971;5819.447152520504;5819.88360232793;5822.301323841166;5828.12578113278;6802.693878775467;6844.486663500158;6893.724251029903;6899.75850845218;6903;5801.390853960358;5803.100519419497;5864;5867.559933005042;5869.765209391577;5700.287464066992;5769.798057067983;5799.159121927381;5834.183214349994;5886.087656413263;6552.901706474407;6553.508486863504;6554.3117972613145;6561.311062338385;6604.801855944329;6754.952982287753;6787;6842.213145488233;6857.177138743383;6860.931390686129;6451.161349024596;6491.058796474579;6572.507061970276;6579.901301480578;6613.404793568602;6510.088587597835;6600.075989361397;6606.6366349849295;6649.135612370361;6736.5958042517605;6701.966490167518;6713.731450741916;6734.225564060196;6736.93263067363;6756.560823546453;6446.709898054505;6567.113439685581;6657.53397262187;6663.933360666525;6668.233153187445;6582.440492557995;6673;6673.065770791996;6691.130153080068;6699.095622090956;6502.772402965874;6509.316521765336;6588.341165883373;6607.504437167136;6609.3060228675295;6470.158879345655;6481.351864813481;6553.475721942138;6622.238442579165;6628.138342015507;6351.079093531504;6359.300476947439;6366.6180029198395;6382.585131966407;6383.265924418565 11:44:03 INFO - PID 9674 | |1;ext.html;826.2687521543432;840.2311884625568;856.9442986205896;884.9336299777518;890.0432035561772;40485.39271910924;41577.58422415775;41694.37458438122;41697.7915110424;41742.791286043524;37348.813255933754;37684.43473347902;37700.43449348255;37747.81126094372;37777.622223777755;7061.682224299919;7145.1068616422945;7169.426445884316;7169.641517924083;7173.60545170018;6952.304769523058;7091.609961452118;7093.609851458168;7094.148702155749;7096.645167741618;6789.219239787413;6884.759033433831;7086.149662040562;7094.85810283794;7121.715131394738;6804.047433359334;6851.040854280404;6853.383195512428;6859.525202081576;6867.828304292408;7703.922960770433;7792.493487923323;7800;7800.18098099697;7800.219978002211;38155.809220954;38620.80689596562;38841.611583884085;38908.22183556313;39016;3492.2317090240363;3539.0975301298004;3539.8938031859084;3540.982295088508;3541.1678255609913;31940.680593194003;32052.519212211835;32106.357872842647;32108.839455802805;32123.678763212538;5190.299309593194;5198.5061419165495;5215.713135777531;5219.086659834514;5242.318498595197;184243;184438.07780961008;184927;185126;185465;48517.514824852005;48531.514684853406;48612.27081593779;48644.27033594499;48711.512884870695;49751.502484974684;49894.50105498971;50023.9995200094;50064.49935500598;50253;15920.442784502718;16153.4346297879;16347.18264086791;16385.50843474698;16396.26216820246;13371.531996380274;13402.06185567001;13408.19550826934;13408.865911340958;13413.061085723906;14263.572092837232;14355.712885742436;14403.279836008158;14491.130532168103;14497.927510362591;5724.427557244242;5753.424657534213;5853.473187413153;5878.911816322759;5886.381929897299;971.8639390485338;1005.492226425665;1005.8742657167854;1009.3287963504188;1010.888802231754;21936.561268774854;22381.216657416913;22404.655720656814;22425.215117471136;22567.887160564092;1097.6706987903597;1102.9889701103048;1106.3693694594165;1106.8229083346625;1106.882049130384;11697.473613687405;11989.340586267665;12036.939815300868;12062.939685301517;12075.516979320904;219867;220776;221510;221816;222159;52482.737586312585;52707.472925271024;52898;53111;55791;1407.7466056109793;1425.0523401937596;1444.7543917534044;1446.7323545144181;1453.0409929446514;26635.60046599341;26774.732252678004;26899.596506052818;27208.11675329884;27367.726322737315;37034.44448333331;37353.62646373502;37369.25261494809;37434.25131497409;37450;207124;208452;208659;208950;210442;34950.47574286337;35024.474632881036;35069.82465087658;35076.29847402986;35107.82446087855;41892.79053604713;43056.138877222904;43520.78239608908;43626;43842.123157536036;31472;31647.52528712025;31826;32263;32432.83783581067;31456.528152078194;31517.36965260636;31569.21076973094;31721.5241771369;32416.35167296594;33820.3235935275;35012.47481287834;35070.47394289036;35258.471122932664;35481.64518354887;31149.221269468446;31446;31583.526247105852;31632.525512116878;31701.682983169874;22851.31446056621;22943;23152.35064688946;23282;23656.29031129069 11:44:03 INFO - PID 9674 | |2;jquery.html;547.4580165636019;561.9297587801525;569.8945695046414;585.3911931591146;585.7042193692183;21690.566188676217;22439.887800561017;22443.438914027138;22447.326580202578;22544.66183007252;23621;24390.14634487789;24746.13388531402;25282.747172528314;25598.23205303839;6439.774607888713;6507.186601674791;6520.282768895418;6524.282328943812;6534.411902928736;5969.403059694039;6446.935530644704;6544.443722283611;6550.312217217172;6554.508411869105;6133.539984501181;6185.350538193492;6193.752249909998;6199.380061993809;6212;6177.258728952532;6207.068939659065;6213.254409470847;6222.751089956397;6234.906476402857;5840.299164100293;6065.666388348639;6136.9079463808075;6140.293866205398;6144.600600960924;28349.14952551406;28720.71279287201;28850.134495965154;28876.989305374213;28883.56674649882;2012.4566367080806;2038.6840039793856;2041.020310251073;2046.9181232750673;2047.6518991771286;18870.811291887043;19237.422877313704;19437.22251109954;19960.600787984305;20065.598688026304;2424.8908799104083;2435.5250726108416;2496.251124662594;2497.225859983411;2498.3254521279337;115614.42192788982;119318;120402;129704.35147824296;135174;14690.711343916182;14695.044822086531;14740.557783266519;14835.554933352018;14860.433495961108;22510.77489225087;22563;22601;22612.773872261067;22637;10126.13927816144;10271;10289.43408112546;10379.325343852626;10411.53148108337;9647.1317581418;9695.854562181574;9730.854037189449;9766.121049105615;9782.461964591874;8816.250618697355;8843.46939183651;8914.509701966324;8989.55052247385;9084.454932704059;2535.9492810143693;2546.2106746908516;2610.464854704819;2611.9477610447684;2709.078913169532;892.6652505310509;926.41832956438;943.6036864516782;945.3666043750703;947.6162154327509;19000.144993475325;19170.90414547946;19565.51086222856;19707.507312317306;19778.10998505071;982.4891056650501;990.0990099009866;993.8012397520525;998.4907697074544;999.160705007797;10776.191785615953;10791.6222932197;10825.350478971286;10919.617813376493;11079.224454288122;498455;502041;502563;508375;512970;110670.44664776625;110943;110989.44505277583;112850.43574782074;114357.42821286006;1019.2050200843354;1053.9209559283083;1111.3554138599593;1123.4888125902694;1162.3607016141088;20527.897360513103;20793.480162996046;20845.270415535382;20938.895305523376;20956.790432096095;54343.184852226455;54846.72576637251;55230.72384638051;55577;56929.430705692415;68266.65866670635;68537;70262;70525.29474705187;70527;14151.64620884445;14251.64370890736;14452.421903124177;14455.13269203851;14463.85536144625;22636.434089147904;22737.431564211027;22932.885335573217;23016.19443319543;23304.184353547545;17384.565385865455;18228.72656910174;18379.72430413518;18611.720824187378;18633.161507731915;15802;16021.118838463997;16178.919105404397;16935.57661058434;16996.405125820536;18444.07779611041;18659.906700466952;18811;18893.338733144275;18980.240790368232;13919.582412527641;13980.650483737987;14113.01208915366;14158.858411415755;14163.858361416254;17944.282228710705;17987.550311242325;18342.17460214267;18371.90814045921;18394 11:44:03 INFO - PID 9674 | |3;mootools.html;1310.6264714556353;1340.6380277325122;1350.230368689847;1372.812517172646;1377.3388773388774;12574.81137782934;13184.34078296085;13204.933975330134;13222.07445478817;15181.696366072672;14964.176970266632;15224;15253.771193432107;15257.465988690397;15354.232288385563;2768.3632764464187;2835.3053501891964;2853.514902466575;2855.828650280979;2858.585505101759;2639.3401649587604;2735.3298441881766;2845.701201373857;2848.117083704048;2870.2537340291465;2837.6027356170152;2879.942401151976;2882.279430142464;2883.1638824740903;2884.033848660701;2705.337192387858;2755.5453350197195;2772.8059035867495;2824.2798086487815;2832.1786681862236;2436;2485.7017157941164;2488.4525404411183;2488.8631125288102;2505.6366826810195;14602.780958285528;14879;14890.255487225704;14964.625884352869;14981.850181498154;7966.203379662045;8237.46456480333;8237.629306681214;8240.093589705128;8259.42184047117;5576.33084029915;5662.292213473316;5707.6290041147195;5805.651660900317;5850.590458667895;1903.3623736048442;1913.6842421000517;1914.301280032792;1957.5204075001573;1964.1750464804672;26150.34624134393;26420.47159056827;26436.471270574482;26452.73547264522;26511.867440662867;6666.566673166229;6698.425869920565;6850;6952.965235173893;7060.082189315356;16756.6648667026;16861;16879;16879.915600422166;16885.83114168867;8083.272505474535;8088;8089;8111.1888811118415;8113.188681131957;7365.3739432147795;7494.737684181027;7497.962510187524;7549.2073332300415;7556.546607203585;5116.053530096944;5195.896082078338;5275.287836142072;5307.336582927134;5309.256704061435;1384.6330722358382;1391.3460673483446;1410.7037522120265;1424.7915730617708;1458.2635768936618;867.1328671328671;888.9866652000096;893.115815342806;897.6947837735202;911.996803516127;7237.782866514013;7298.051253337032;7326.780196594111;7378.889316660255;7440.66517006736;945.4894357047117;997.1324947295899;997.217184510156;1005.8742657167854;1009.1220638044948;4234.915301693949;4445.488768791565;4449.666275029385;4453.131639330364;4484.8430304939175;21542.35372938814;21706.13175472995;22021.889890550767;22258.109675612795;22540.21109261168;21887.452813679785;21990.780092199195;22034.33896983093;22156.778432215793;22252.88873555622;9236.214921731727;9718.173955213744;9818.312718109806;9822.901770982342;9847.852282215628;9024.774380640536;9064.093590640883;9125.17873391398;9193.310501712265;9247.76880577991;18674;18765.624687506446;18773.436796896116;18786.436406907815;19001.33495327712;19174.61650767005;19182.616347673247;19474.123664435418;19512.707309390655;19829.702554461983;12048.457819397972;12351.444185011876;12379.504819807467;12404.19372740769;12416.192947458387;13920.791188132389;13962.79055814184;14008.369623367176;14059;14085.366158522686;10756.515956781806;10834.837477437686;10988.780224395627;11078.889211108108;11282.153838462313;11120.054795342163;11149.665510034387;11156.44217789091;11453.59912403062;11558.537658493902;9705.757356065873;9778.511074446107;9836.655717049869;9893.554790034323;9921.950390248003;6749.493787965824;6867.3476019778045;6922.065521154781;6965.33829286217;7018.192907815463;7025.402840758593;7115.928840711526;7237.3486386223385;7250.746223882139;7311.963440182765 11:44:03 INFO - PID 9674 | |4;prototype.html;497.07295893159244;510.25248011662916;523.9808572326826;527.1697077103562;533.810497273468;6369.821583007141;6431.903521447176;6441.83895402614;6492.318306577812;6493.772717954873;6189.628622282667;6294.402031806982;6312.612734149768;6346.270178929424;6352.745890164388;4892.902141957159;5009.849704508871;5048.671836330645;5052.9242061369105;5059.721715305675;5049.293098966147;5097.158968770148;5108.208227724708;5132.255822905677;5133.383993920735;5016.172331565287;5031.4465408805;5031.6729412588065;5058.772355244005;5102.311187989611;5018.824341148043;5035.733919736115;5066.36670416198;5091.592672586185;5093.236014597822;4539.909201815978;4552.1350943320995;4560.566746159109;4578.313253012042;4578.679492435531;6292.968535157295;6309.116723658692;6315.463185629227;6337.732453509317;6346.0798184263485;5778.42215778423;5785.17766903424;5796.362400135981;5819.563532735062;5858.150568167592;6622.6357550334715;6628.602283862983;6662.833429164261;6704.865902681919;6778.118844550227;4896.485868983741;4921.138800709861;4934.80260789568;4953.968872762186;4955.306257124005;6974;7057.470689698293;7081.256468070881;7093.929060709378;7107.786766397016;5023.49765023502;5031.4465408805;5031.823886163967;5037.949620503821;5058.797648094035;5107.82917260163;5113.463086375951;5132.178851383761;5133.281340612317;5161.664491808096;5787.768489260382;5788.623739456922;5789.739461724148;5797.36229014808;5810.1865738796605;6385;6559.901601475886;6623.238327592292;6677.899831502435;6757.763478278237;1671.2729962466124;1728.6629107324202;1736.097229440709;1759.7096479081065;1772.3619496981075;1205.300526257972;1210.0803389424102;1214.1682947181032;1217.2392254840724;1220.5544976083843;5710.428957104256;5722.456366645162;5728.455796699307;5793.188953546507;5822.33043200029;6692.4903161314505;6803.387695107365;6855.806142034601;6857.7256909723055;6936.687849046805;5804.868050730067;5827.921834460553;5829.143719577377;5844.590878638454;5869.911951320733;3586.4261718124976;3611.205534782344;3612.223371975038;3616.6383361663625;3618.819059047037;6670.566413183127;6689.264180940093;6696.799096027127;6698.83252918681;6702.296258892844;7071.92928070723;7108.573485590881;7124.46566507514;7125.42996560274;7143.642817859086;6490.707918143695;6576.901346479806;6600.669966501751;6609.933900661124;6610.636414997221;6825.317468253135;6877.931220687729;6879.036934829028;6895.55178913369;6904.482163837632;6747.797566072829;6761.830954226184;6801.693923773343;6821.658917054227;6900.378965893094;6444.420002199825;6533.314002029909;6568.704408301543;6572.507061970467;6572.638504882278;4943.797771893862;4992;4992.350994370709;5004.324416203766;5004.3994720633755;6621.867562648624;6826.556273842184;6856.9314306856295;6857.794266172023;6864.279250678607;6268.498520118471;6435.195600549931;6530.967345163243;6664.200295964515;6716.731330746911;6507.089007539043;6555.246146693191;6602.570832895846;6656.23453302857;6671.466282697275;6300.621962682254;6372.206355229939;6378.712957916812;6446.967765161332;6595.340465953366;6542.574732642363;6570.342965703391;6615.636140012345;6641.634710090798;6687.966560167168;6401.199850018747;6438.227412710505;6446.967765161145;6501.05734668461;6509.934900650933 11:44:03 INFO - PID 9674 | |5;yui.html;884.3058199313532;894.2711689972672;918.912703293187;919.7516670498966;937.3110763588763;16197.595060123487;17030.31878724851;17093.914530427344;17113;17186.742198866996;15909;16096.275667594957;16281.511554653349;16310.75533866993;16601.916990415062;966.6858271061916;981.6858605246324;987.7777500062465;988.0810845913297;989.5200827598609;979.9706008819746;983.8671779309773;985.1183191044047;985.2167526816198;986.378581493658;978.3493976505615;1011.9645812396568;1017.1252722658508;1018.5365658625308;1018.9592416303338;997.0727223681973;999.8100360931436;1003.3528374198601;1004.4023805835552;1006.3760468509498;715.4455297144702;738.4314078159787;746.5296862976345;747.215423805008;747.4618274842105;17121.486355409357;17266.22301996413;17274.913625431916;17284.39504617345;17291;21097.789022109737;21139.47151321214;21504.354869353945;21527.892360538255;21632.459188520257;16867.397597228242;17387.478375648752;17446.21492032849;17449.21478533469;17540.473785786446;3779.5842457329672;3783.4324851272254;3818.16000479894;3818.236352729465;3818.579956204815;127512.36243818814;129867;131791;133066;135664.999999999;16393.180340982904;16574.83425165757;16943.15284235783;16986.915065424593;16987.74518382225;30431.543526847116;30565.541516877263;30648.846755766524;30650.846745766576;30664.080077597708;8714.172153645393;8870.068642792543;8881.24509416694;8885.02264750877;8886.289096872235;3996.7402118862183;4073.714839961174;4077.204945035749;4084.4281800547947;4093.3246014407887;5422.837314880481;5491;5584.86037849057;5619.4099619540175;5632.211490391349;1031.5461197073414;1044.7492601775518;1055.1295181475314;1056.7410984308895;1059.5285098131412;664.3588936676034;682.6518475577392;683.4293365040247;692.51869950384;702.1854648607591;11758.470868810924;12191.817122743167;12439.875601243872;12590.937045314899;12884;677.1434135818193;686.807693845724;698.2075344484048;700.6146619359332;703.9472039596948;5480.369757477862;5511.751971161308;5569.248151499496;5612.242347283146;5655.660660360391;129962;132776;132966;133418;136571.31714341365;82155;102127;108862.45568772264;111845;114670;90796.54601727081;91896;93280.53359733158;93423.53288233651;93823.53088234515;13057.347132643139;13070.738585228431;13136.934315328363;13217.933910330386;13298.601041968757;42530.149397011264;42710.35934461048;43070.35394469148;43811.34282985694;44055.559444405146;56708.71645641745;56847.71576142093;57019;57571.42428575828;57728.42271577231;17184.484465466056;17382.30470781205;17414.912925435292;17592.73610895863;17662.735058974384;20061.59876802485;20395;20421;20497.2825951091;20691.379258622266;17756.3785267515;17854.19656115452;18254;18411.079446027376;18609.162587683317;16837.66324673475;17112.657746844743;17244.396446124327;17265.22306496236;17336.65326693484;17564.38524651631;17581.736273956158;17640.38258660941;17745.911270443565;17813;12175.695607609881;12180.208286461351;12368.690782730504;12646.05154613426;12672.239665620093;13519.459221631418;13595.388207530883;13712.108712933627;13735.313234338044;13754.174749515061 11:44:03 INFO - PID 9674 | __end_tp_report 11:44:03 INFO - PID 9674 | __start_cc_report 11:44:03 INFO - PID 9674 | _x_x_mozilla_cycle_collect,372 11:44:03 INFO - PID 9674 | __end_cc_report 11:44:03 INFO - PID 9674 | __startTimestamp1505501043737__endTimestamp 11:44:03 INFO - PID 9674 | 11:44:03 INFO - PID 9674 | ------- Summary: start ------- 11:44:03 INFO - PID 9674 | Number of tests: 6 11:44:03 INFO - PID 9674 | 11:44:03 INFO - PID 9674 | [#0] dojo.html Cycles:165 Average:6218.00 Median:6451.26 stddev:753.56 (11.7%) stddev-sans-first:716.73 11:44:03 INFO - PID 9674 | Values: 3162.4 3165.7 3176.7 3184.2 3190.7 6111.5 6246.7 6278.3 6302.4 6366.2 6210.4 6249.9 6255.6 6277.3 6285.5 5745.5 5749.5 5762.0 5785.8 5799.2 5780.3 5786.9 5802.1 5821.0 5861.1 5788.2 5820.8 5822.4 5843.3 5860.9 5557.9 5830.6 5883.1 5908.7 5915.8 5624.4 5641.8 5674.3 5727.5 5790.4 6323.1 6340.1 6392.0 6414.4 6423.1 6604.6 6709.4 6709.8 6768.7 6823.4 6816.2 6852.7 6855.7 6858.9 6872.2 6250.2 6316.1 6354.0 6366.3 6366.3 6963.4 6981.1 7024.4 7055.3 7061.2 6451.3 6583.7 6619.9 6630.4 6719.1 6749.2 6807.7 6837.0 6838.6 6839.9 6777.6 6793.4 6802.7 6802.8 6831.0 6696.7 6773.3 6776.3 6779.0 6784.3 5280.8 5285.7 5347.5 5379.3 5380.1 4558.5 4580.6 4609.1 4659.1 4683.7 5813.1 5819.4 5819.9 5822.3 5828.1 6802.7 6844.5 6893.7 6899.8 6903.0 5801.4 5803.1 5864.0 5867.6 5869.8 5700.3 5769.8 5799.2 5834.2 5886.1 6552.9 6553.5 6554.3 6561.3 6604.8 6755.0 6787.0 6842.2 6857.2 6860.9 6451.2 6491.1 6572.5 6579.9 6613.4 6510.1 6600.1 6606.6 6649.1 6736.6 6702.0 6713.7 6734.2 6736.9 6756.6 6446.7 6567.1 6657.5 6663.9 6668.2 6582.4 6673.0 6673.1 6691.1 6699.1 6502.8 6509.3 6588.3 6607.5 6609.3 6470.2 6481.4 6553.5 6622.2 6628.1 6351.1 6359.3 6366.6 6382.6 6383.3 11:44:03 INFO - PID 9674 | 11:44:03 INFO - PID 9674 | [#1] ext.html Cycles:180 Average:37378.37 Median:35073.39 stddev:53213.95 (151.7%) stddev-sans-first:53292.45 11:44:03 INFO - PID 9674 | Values: 826.3 840.2 856.9 884.9 890.0 40485.4 41577.6 41694.4 41697.8 41742.8 37348.8 37684.4 37700.4 37747.8 37777.6 7061.7 7145.1 7169.4 7169.6 7173.6 6952.3 7091.6 7093.6 7094.1 7096.6 6789.2 6884.8 7086.1 7094.9 7121.7 6804.0 6851.0 6853.4 6859.5 6867.8 7703.9 7792.5 7800.0 7800.2 7800.2 38155.8 38620.8 38841.6 38908.2 39016.0 3492.2 3539.1 3539.9 3541.0 3541.2 31940.7 32052.5 32106.4 32108.8 32123.7 5190.3 5198.5 5215.7 5219.1 5242.3 184243.0 184438.1 184927.0 185126.0 185465.0 48517.5 48531.5 48612.3 48644.3 48711.5 49751.5 49894.5 50024.0 50064.5 50253.0 15920.4 16153.4 16347.2 16385.5 16396.3 13371.5 13402.1 13408.2 13408.9 13413.1 14263.6 14355.7 14403.3 14491.1 14497.9 5724.4 5753.4 5853.5 5878.9 5886.4 971.9 1005.5 1005.9 1009.3 1010.9 21936.6 22381.2 22404.7 22425.2 22567.9 1097.7 1103.0 1106.4 1106.8 1106.9 11697.5 11989.3 12036.9 12062.9 12075.5 219867.0 220776.0 221510.0 221816.0 222159.0 52482.7 52707.5 52898.0 53111.0 55791.0 1407.7 1425.1 1444.8 1446.7 1453.0 26635.6 26774.7 26899.6 27208.1 27367.7 37034.4 37353.6 37369.3 37434.3 37450.0 207124.0 208452.0 208659.0 208950.0 210442.0 34950.5 35024.5 35069.8 35076.3 35107.8 41892.8 43056.1 43520.8 43626.0 43842.1 31472.0 31647.5 31826.0 32263.0 32432.8 31456.5 31517.4 31569.2 31721.5 32416.4 33820.3 35012.5 35070.5 35258.5 35481.6 31149.2 31446.0 31583.5 31632.5 31701.7 22851.3 22943.0 23152.4 23282.0 23656.3 11:44:03 INFO - PID 9674 | 11:44:03 INFO - PID 9674 | [#2] jquery.html Cycles:180 Average:34545.72 Median:22687.22 stddev:84322.68 (371.7%) stddev-sans-first:84520.59 11:44:03 INFO - PID 9674 | Values: 547.5 561.9 569.9 585.4 585.7 21690.6 22439.9 22443.4 22447.3 22544.7 23621.0 24390.1 24746.1 25282.7 25598.2 6439.8 6507.2 6520.3 6524.3 6534.4 5969.4 6446.9 6544.4 6550.3 6554.5 6133.5 6185.4 6193.8 6199.4 6212.0 6177.3 6207.1 6213.3 6222.8 6234.9 5840.3 6065.7 6136.9 6140.3 6144.6 28349.1 28720.7 28850.1 28877.0 28883.6 2012.5 2038.7 2041.0 2046.9 2047.7 18870.8 19237.4 19437.2 19960.6 20065.6 2424.9 2435.5 2496.3 2497.2 2498.3 115614.4 119318.0 120402.0 129704.4 135174.0 14690.7 14695.0 14740.6 14835.6 14860.4 22510.8 22563.0 22601.0 22612.8 22637.0 10126.1 10271.0 10289.4 10379.3 10411.5 9647.1 9695.9 9730.9 9766.1 9782.5 8816.3 8843.5 8914.5 8989.6 9084.5 2535.9 2546.2 2610.5 2611.9 2709.1 892.7 926.4 943.6 945.4 947.6 19000.1 19170.9 19565.5 19707.5 19778.1 982.5 990.1 993.8 998.5 999.2 10776.2 10791.6 10825.4 10919.6 11079.2 498455.0 502041.0 502563.0 508375.0 512970.0 110670.4 110943.0 110989.4 112850.4 114357.4 1019.2 1053.9 1111.4 1123.5 1162.4 20527.9 20793.5 20845.3 20938.9 20956.8 54343.2 54846.7 55230.7 55577.0 56929.4 68266.7 68537.0 70262.0 70525.3 70527.0 14151.6 14251.6 14452.4 14455.1 14463.9 22636.4 22737.4 22932.9 23016.2 23304.2 17384.6 18228.7 18379.7 18611.7 18633.2 15802.0 16021.1 16178.9 16935.6 16996.4 18444.1 18659.9 18811.0 18893.3 18980.2 13919.6 13980.7 14113.0 14158.9 14163.9 17944.3 17987.6 18342.2 18371.9 18394.0 11:44:03 INFO - PID 9674 | 11:44:03 INFO - PID 9674 | [#3] mootools.html Cycles:180 Average:9281.05 Median:2761.95 stddev:6691.79 (242.3%) stddev-sans-first:6683.77 11:44:03 INFO - PID 9674 | Values: 1310.6 1340.6 1350.2 1372.8 1377.3 12574.8 13184.3 13204.9 13222.1 15181.7 14964.2 15224.0 15253.8 15257.5 15354.2 2768.4 2835.3 2853.5 2855.8 2858.6 2639.3 2735.3 2845.7 2848.1 2870.3 2837.6 2879.9 2882.3 2883.2 2884.0 2705.3 2755.5 2772.8 2824.3 2832.2 2436.0 2485.7 2488.5 2488.9 2505.6 14602.8 14879.0 14890.3 14964.6 14981.9 7966.2 8237.5 8237.6 8240.1 8259.4 5576.3 5662.3 5707.6 5805.7 5850.6 1903.4 1913.7 1914.3 1957.5 1964.2 26150.3 26420.5 26436.5 26452.7 26511.9 6666.6 6698.4 6850.0 6953.0 7060.1 16756.7 16861.0 16879.0 16879.9 16885.8 8083.3 8088.0 8089.0 8111.2 8113.2 7365.4 7494.7 7498.0 7549.2 7556.5 5116.1 5195.9 5275.3 5307.3 5309.3 1384.6 1391.3 1410.7 1424.8 1458.3 867.1 889.0 893.1 897.7 912.0 7237.8 7298.1 7326.8 7378.9 7440.7 945.5 997.1 997.2 1005.9 1009.1 4234.9 4445.5 4449.7 4453.1 4484.8 21542.4 21706.1 22021.9 22258.1 22540.2 21887.5 21990.8 22034.3 22156.8 22252.9 9236.2 9718.2 9818.3 9822.9 9847.9 9024.8 9064.1 9125.2 9193.3 9247.8 18674.0 18765.6 18773.4 18786.4 19001.3 19174.6 19182.6 19474.1 19512.7 19829.7 12048.5 12351.4 12379.5 12404.2 12416.2 13920.8 13962.8 14008.4 14059.0 14085.4 10756.5 10834.8 10988.8 11078.9 11282.2 11120.1 11149.7 11156.4 11453.6 11558.5 9705.8 9778.5 9836.7 9893.6 9922.0 6749.5 6867.3 6922.1 6965.3 7018.2 7025.4 7115.9 7237.3 7250.7 7312.0 11:44:03 INFO - PID 9674 | 11:44:03 INFO - PID 9674 | [#4] prototype.html Cycles:180 Average:5594.50 Median:6310.86 stddev:1581.59 (25.1%) stddev-sans-first:1539.05 11:44:03 INFO - PID 9674 | Values: 497.1 510.3 524.0 527.2 533.8 6369.8 6431.9 6441.8 6492.3 6493.8 6189.6 6294.4 6312.6 6346.3 6352.7 4892.9 5009.8 5048.7 5052.9 5059.7 5049.3 5097.2 5108.2 5132.3 5133.4 5016.2 5031.4 5031.7 5058.8 5102.3 5018.8 5035.7 5066.4 5091.6 5093.2 4539.9 4552.1 4560.6 4578.3 4578.7 6293.0 6309.1 6315.5 6337.7 6346.1 5778.4 5785.2 5796.4 5819.6 5858.2 6622.6 6628.6 6662.8 6704.9 6778.1 4896.5 4921.1 4934.8 4954.0 4955.3 6974.0 7057.5 7081.3 7093.9 7107.8 5023.5 5031.4 5031.8 5037.9 5058.8 5107.8 5113.5 5132.2 5133.3 5161.7 5787.8 5788.6 5789.7 5797.4 5810.2 6385.0 6559.9 6623.2 6677.9 6757.8 1671.3 1728.7 1736.1 1759.7 1772.4 1205.3 1210.1 1214.2 1217.2 1220.6 5710.4 5722.5 5728.5 5793.2 5822.3 6692.5 6803.4 6855.8 6857.7 6936.7 5804.9 5827.9 5829.1 5844.6 5869.9 3586.4 3611.2 3612.2 3616.6 3618.8 6670.6 6689.3 6696.8 6698.8 6702.3 7071.9 7108.6 7124.5 7125.4 7143.6 6490.7 6576.9 6600.7 6609.9 6610.6 6825.3 6877.9 6879.0 6895.6 6904.5 6747.8 6761.8 6801.7 6821.7 6900.4 6444.4 6533.3 6568.7 6572.5 6572.6 4943.8 4992.0 4992.4 5004.3 5004.4 6621.9 6826.6 6856.9 6857.8 6864.3 6268.5 6435.2 6531.0 6664.2 6716.7 6507.1 6555.2 6602.6 6656.2 6671.5 6300.6 6372.2 6378.7 6447.0 6595.3 6542.6 6570.3 6615.6 6641.6 6688.0 6401.2 6438.2 6447.0 6501.1 6509.9 11:44:03 INFO - PID 9674 | 11:44:03 INFO - PID 9674 | [#5] yui.html Cycles:180 Average:24348.90 Median:19335.38 stddev:34936.44 (180.7%) stddev-sans-first:34990.02 11:44:03 INFO - PID 9674 | Values: 884.3 894.3 918.9 919.8 937.3 16197.6 17030.3 17093.9 17113.0 17186.7 15909.0 16096.3 16281.5 16310.8 16601.9 966.7 981.7 987.8 988.1 989.5 980.0 983.9 985.1 985.2 986.4 978.3 1012.0 1017.1 1018.5 1019.0 997.1 999.8 1003.4 1004.4 1006.4 715.4 738.4 746.5 747.2 747.5 17121.5 17266.2 17274.9 17284.4 17291.0 21097.8 21139.5 21504.4 21527.9 21632.5 16867.4 17387.5 17446.2 17449.2 17540.5 3779.6 3783.4 3818.2 3818.2 3818.6 127512.4 129867.0 131791.0 133066.0 135665.0 16393.2 16574.8 16943.2 16986.9 16987.7 30431.5 30565.5 30648.8 30650.8 30664.1 8714.2 8870.1 8881.2 8885.0 8886.3 3996.7 4073.7 4077.2 4084.4 4093.3 5422.8 5491.0 5584.9 5619.4 5632.2 1031.5 1044.7 1055.1 1056.7 1059.5 664.4 682.7 683.4 692.5 702.2 11758.5 12191.8 12439.9 12590.9 12884.0 677.1 686.8 698.2 700.6 703.9 5480.4 5511.8 5569.2 5612.2 5655.7 129962.0 132776.0 132966.0 133418.0 136571.3 82155.0 102127.0 108862.5 111845.0 114670.0 90796.5 91896.0 93280.5 93423.5 93823.5 13057.3 13070.7 13136.9 13217.9 13298.6 42530.1 42710.4 43070.4 43811.3 44055.6 56708.7 56847.7 57019.0 57571.4 57728.4 17184.5 17382.3 17414.9 17592.7 17662.7 20061.6 20395.0 20421.0 20497.3 20691.4 17756.4 17854.2 18254.0 18411.1 18609.2 16837.7 17112.7 17244.4 17265.2 17336.7 17564.4 17581.7 17640.4 17745.9 17813.0 12175.7 12180.2 12368.7 12646.1 12672.2 13519.5 13595.4 13712.1 13735.3 13754.2 11:44:03 INFO - PID 9674 | -------- Summary: end -------- 11:44:03 INFO - PID 9674 | 11:44:04 INFO - TEST-INFO | 9674: exit 0 11:44:04 INFO - TEST-OK | dromaeo_css | took 1109071ms 11:44:04 INFO - TEST-START | kraken 11:44:04 INFO - Initialising browser for kraken test... 11:44:04 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:59109/getInfo.html -profile /tmp/tmpLRD3vG/profile 11:44:04 INFO - TEST-INFO | started process 10039 (/builds/slave/test/build/application/firefox/firefox http://localhost:59109/getInfo.html) 11:44:09 INFO - TEST-INFO | 10039: exit 0 11:44:09 INFO - Browser initialized. 11:44:09 INFO - Running cycle 1/1 for kraken test... 11:44:09 INFO - Using env: {'DISPLAY': ':0', 11:44:09 INFO - 'HOME': '/home/cltbld', 11:44:09 INFO - 'JSGC_DISABLE_POISONING': '1', 11:44:09 INFO - 'LANG': 'en_US.UTF-8', 11:44:09 INFO - 'LANGUAGE': 'en_US:en', 11:44:09 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 11:44:09 INFO - 'LOGNAME': 'cltbld', 11:44:09 INFO - 'MAIL': '/var/mail/cltbld', 11:44:09 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:44:09 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:44:09 INFO - 'MOZ_CRASHREPORTER': '1', 11:44:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:44:09 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 11:44:09 INFO - 'MOZ_NO_REMOTE': '1', 11:44:09 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:44:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:44:09 INFO - 'NO_EM_RESTART': '1', 11:44:09 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:44:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:44:09 INFO - 'PWD': '/builds/slave/test', 11:44:09 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:44:09 INFO - 'RUST_BACKTRACE': 'full', 11:44:09 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 11:44:09 INFO - 'SHELL': '/bin/bash', 11:44:09 INFO - 'SHLVL': '1', 11:44:09 INFO - 'STYLO_FORCE_DISABLED': '1', 11:44:09 INFO - 'TERM': 'linux', 11:44:09 INFO - 'TMOUT': '86400', 11:44:09 INFO - 'USER': 'cltbld', 11:44:09 INFO - 'XDG_SESSION_COOKIE': '20e20d796406ba5117c4a6f1000001ba-1505497411.419713-283184589', 11:44:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:44:09 INFO - '_': '/tools/buildbot/bin/python'} 11:44:09 INFO - TEST-INFO | started process 10273 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpLRD3vG/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 11:44:10 INFO - PID 10273 | 11:44:10 INFO - PID 10273 | (/builds/slave/test/build/application/firefox/firefox:10322): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 11:44:10 INFO - PID 10273 | 11:44:20 INFO - PID 10273 | RSS: Main: 173670400 11:44:20 INFO - PID 10273 | 11:44:23 INFO - PID 10273 | Cycle 1(1): loaded http://localhost:59109/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59109/tests/kraken/driver.html?testName=audio-beat-detection) 11:44:24 INFO - PID 10273 | RSS: Main: 178372608 11:44:24 INFO - PID 10273 | 11:44:27 INFO - PID 10273 | Cycle 1(1): loaded http://localhost:59109/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59109/tests/kraken/driver.html?testName=audio-dft) 11:44:27 INFO - PID 10273 | RSS: Main: 179187712 11:44:27 INFO - PID 10273 | 11:44:30 INFO - PID 10273 | Cycle 1(1): loaded http://localhost:59109/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59109/tests/kraken/driver.html?testName=audio-fft) 11:44:31 INFO - PID 10273 | RSS: Main: 174518272 11:44:31 INFO - PID 10273 | 11:44:33 INFO - PID 10273 | Cycle 1(1): loaded http://localhost:59109/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59109/tests/kraken/driver.html?testName=audio-oscillator) 11:44:33 INFO - PID 10273 | RSS: Main: 175517696 11:44:33 INFO - PID 10273 | 11:44:36 INFO - PID 10273 | Cycle 1(1): loaded http://localhost:59109/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59109/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:44:36 INFO - PID 10273 | RSS: Main: 175460352 11:44:36 INFO - PID 10273 | 11:44:39 INFO - PID 10273 | Cycle 1(1): loaded http://localhost:59109/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59109/tests/kraken/driver.html?testName=imaging-darkroom) 11:44:40 INFO - PID 10273 | RSS: Main: 178208768 11:44:40 INFO - PID 10273 | 11:44:44 INFO - PID 10273 | Cycle 1(1): loaded http://localhost:59109/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59109/tests/kraken/driver.html?testName=imaging-desaturate) 11:44:44 INFO - PID 10273 | RSS: Main: 177922048 11:44:44 INFO - PID 10273 | 11:44:47 INFO - PID 10273 | Cycle 1(1): loaded http://localhost:59109/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59109/tests/kraken/driver.html?testName=json-parse-financial) 11:44:48 INFO - PID 10273 | RSS: Main: 177864704 11:44:48 INFO - PID 10273 | 11:44:50 INFO - PID 10273 | Cycle 1(1): loaded http://localhost:59109/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59109/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:44:50 INFO - PID 10273 | RSS: Main: 178569216 11:44:50 INFO - PID 10273 | 11:44:52 INFO - PID 10273 | Cycle 1(1): loaded http://localhost:59109/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59109/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:44:52 INFO - PID 10273 | RSS: Main: 177934336 11:44:52 INFO - PID 10273 | 11:44:55 INFO - PID 10273 | Cycle 1(1): loaded http://localhost:59109/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59109/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:44:55 INFO - PID 10273 | RSS: Main: 175230976 11:44:55 INFO - PID 10273 | 11:44:58 INFO - PID 10273 | Cycle 1(1): loaded http://localhost:59109/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59109/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:44:58 INFO - PID 10273 | RSS: Main: 175652864 11:44:58 INFO - PID 10273 | 11:45:01 INFO - PID 10273 | Cycle 1(1): loaded http://localhost:59109/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59109/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:45:02 INFO - PID 10273 | RSS: Main: 175484928 11:45:02 INFO - PID 10273 | 11:45:04 INFO - PID 10273 | Cycle 1(1): loaded http://localhost:59109/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59109/tests/kraken/driver.html?testName=ai-astar) 11:45:04 INFO - PID 10273 | RSS: Main: 176910336 11:45:04 INFO - PID 10273 | 11:45:04 INFO - PID 10273 | __start_tp_report 11:45:04 INFO - PID 10273 | _x_x_mozilla_page_load 11:45:04 INFO - PID 10273 | _x_x_mozilla_page_load_details 11:45:04 INFO - PID 10273 | |i|pagename|runs| 11:45:04 INFO - PID 10273 | |0;ai-astar;108;108;109;107;108;101;110;107;107;109 11:45:04 INFO - PID 10273 | |1;audio-beat-detection;116;116;118;115;121;117;116;149;121;116 11:45:04 INFO - PID 10273 | |2;audio-dft;164;162;163;164;162;169;165;168;165;164 11:45:04 INFO - PID 10273 | |3;audio-fft;74;74;73;78;74;75;77;153;74;77 11:45:04 INFO - PID 10273 | |4;audio-oscillator;80;79;87;79;79;78;79;79;80;78 11:45:04 INFO - PID 10273 | |5;imaging-gaussian-blur;112;114;113;110;114;113;112;113;113;114 11:45:04 INFO - PID 10273 | |6;imaging-darkroom;148;149;148;148;147;148;149;149;150;150 11:45:04 INFO - PID 10273 | |7;imaging-desaturate;94;95;94;94;98;99;94;95;94;98 11:45:04 INFO - PID 10273 | |8;json-parse-financial;53;54;53;53;52;52;54;53;55;54 11:45:04 INFO - PID 10273 | |9;json-stringify-tinderbox;38;38;38;38;38;38;38;38;38;38 11:45:04 INFO - PID 10273 | |10;stanford-crypto-aes;73;75;74;74;75;75;73;78;75;73 11:45:04 INFO - PID 10273 | |11;stanford-crypto-ccm;110;111;112;116;117;123;112;113;115;110 11:45:04 INFO - PID 10273 | |12;stanford-crypto-pbkdf2;170;174;168;172;170;168;176;173;180;171 11:45:04 INFO - PID 10273 | |13;stanford-crypto-sha256-iterative;66;65;65;73;67;68;69;66;69;68 11:45:04 INFO - PID 10273 | __end_tp_report 11:45:04 INFO - PID 10273 | __start_cc_report 11:45:04 INFO - PID 10273 | _x_x_mozilla_cycle_collect,947 11:45:04 INFO - PID 10273 | __end_cc_report 11:45:04 INFO - PID 10273 | __startTimestamp1505501104598__endTimestamp 11:45:04 INFO - PID 10273 | 11:45:04 INFO - PID 10273 | ------- Summary: start ------- 11:45:04 INFO - PID 10273 | Number of tests: 14 11:45:04 INFO - PID 10273 | 11:45:04 INFO - PID 10273 | [#0] ai-astar Cycles:10 Average:107.40 Median:108.00 stddev:2.46 (2.3%) stddev-sans-first:2.60 11:45:04 INFO - PID 10273 | Values: 108.0 108.0 109.0 107.0 108.0 101.0 110.0 107.0 107.0 109.0 11:45:04 INFO - PID 10273 | 11:45:04 INFO - PID 10273 | [#1] audio-beat-detection Cycles:10 Average:120.50 Median:117.50 stddev:10.23 (8.7%) stddev-sans-first:10.72 11:45:04 INFO - PID 10273 | Values: 116.0 116.0 118.0 115.0 121.0 117.0 116.0 149.0 121.0 116.0 11:45:04 INFO - PID 10273 | 11:45:04 INFO - PID 10273 | [#2] audio-dft Cycles:10 Average:164.60 Median:164.50 stddev:2.32 (1.4%) stddev-sans-first:2.45 11:45:04 INFO - PID 10273 | Values: 164.0 162.0 163.0 164.0 162.0 169.0 165.0 168.0 165.0 164.0 11:45:04 INFO - PID 10273 | 11:45:04 INFO - PID 10273 | [#3] audio-fft Cycles:10 Average:82.90 Median:74.50 stddev:24.69 (33.1%) stddev-sans-first:25.97 11:45:04 INFO - PID 10273 | Values: 74.0 74.0 73.0 78.0 74.0 75.0 77.0 153.0 74.0 77.0 11:45:04 INFO - PID 10273 | 11:45:04 INFO - PID 10273 | [#4] audio-oscillator Cycles:10 Average:79.80 Median:79.00 stddev:2.62 (3.3%) stddev-sans-first:2.77 11:45:04 INFO - PID 10273 | Values: 80.0 79.0 87.0 79.0 79.0 78.0 79.0 79.0 80.0 78.0 11:45:04 INFO - PID 10273 | 11:45:04 INFO - PID 10273 | [#5] imaging-gaussian-blur Cycles:10 Average:112.80 Median:113.00 stddev:1.23 (1.1%) stddev-sans-first:1.27 11:45:04 INFO - PID 10273 | Values: 112.0 114.0 113.0 110.0 114.0 113.0 112.0 113.0 113.0 114.0 11:45:04 INFO - PID 10273 | 11:45:04 INFO - PID 10273 | [#6] imaging-darkroom Cycles:10 Average:148.60 Median:149.00 stddev:0.97 (0.6%) stddev-sans-first:1.00 11:45:04 INFO - PID 10273 | Values: 148.0 149.0 148.0 148.0 147.0 148.0 149.0 149.0 150.0 150.0 11:45:04 INFO - PID 10273 | 11:45:04 INFO - PID 10273 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:95.00 stddev:2.01 (2.1%) stddev-sans-first:2.06 11:45:04 INFO - PID 10273 | Values: 94.0 95.0 94.0 94.0 98.0 99.0 94.0 95.0 94.0 98.0 11:45:04 INFO - PID 10273 | 11:45:04 INFO - PID 10273 | [#8] json-parse-financial Cycles:10 Average:53.30 Median:53.50 stddev:0.95 (1.8%) stddev-sans-first:1.00 11:45:04 INFO - PID 10273 | Values: 53.0 54.0 53.0 53.0 52.0 52.0 54.0 53.0 55.0 54.0 11:45:04 INFO - PID 10273 | 11:45:04 INFO - PID 10273 | [#9] json-stringify-tinderbox Cycles:10 Average:38.00 Median:38.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 11:45:04 INFO - PID 10273 | Values: 38.0 38.0 38.0 38.0 38.0 38.0 38.0 38.0 38.0 38.0 11:45:04 INFO - PID 10273 | 11:45:04 INFO - PID 10273 | [#10] stanford-crypto-aes Cycles:10 Average:74.50 Median:75.00 stddev:1.51 (2.0%) stddev-sans-first:1.50 11:45:04 INFO - PID 10273 | Values: 73.0 75.0 74.0 74.0 75.0 75.0 73.0 78.0 75.0 73.0 11:45:04 INFO - PID 10273 | 11:45:04 INFO - PID 10273 | [#11] stanford-crypto-ccm Cycles:10 Average:113.90 Median:114.00 stddev:4.01 (3.5%) stddev-sans-first:4.00 11:45:04 INFO - PID 10273 | Values: 110.0 111.0 112.0 116.0 117.0 123.0 112.0 113.0 115.0 110.0 11:45:04 INFO - PID 10273 | 11:45:04 INFO - PID 10273 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.20 Median:172.50 stddev:3.74 (2.2%) stddev-sans-first:3.88 11:45:04 INFO - PID 10273 | Values: 170.0 174.0 168.0 172.0 170.0 168.0 176.0 173.0 180.0 171.0 11:45:04 INFO - PID 10273 | 11:45:04 INFO - PID 10273 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.60 Median:68.00 stddev:2.41 (3.5%) stddev-sans-first:2.49 11:45:04 INFO - PID 10273 | Values: 66.0 65.0 65.0 73.0 67.0 68.0 69.0 66.0 69.0 68.0 11:45:04 INFO - PID 10273 | -------- Summary: end -------- 11:45:04 INFO - PID 10273 | 11:45:04 INFO - PID 10273 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 11:45:05 INFO - TEST-INFO | 10273: exit 0 11:45:05 INFO - TEST-OK | kraken | took 60882ms 11:45:05 INFO - SUITE-END | took 1169s 11:45:05 INFO - Completed test suite (00:19:30) 11:45:05 INFO - javascript benchmark 11:45:05 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s", "stylo_disabled"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8511.274322044195, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3162.367526494701, 3165.7467402607795, 3176.7140957313836, 3184.188032051828, 3190.6968837960417, 6111.480524155441, 6246.687665616712, 6278.2779980302275, 6302.369763023696, 6366.2360516738, 6210.441060304572, 6249.9062514062325, 6255.59338642989, 6277.309495955453, 6285.465735412484, 5745.4829065384, 5749.511291540224, 5762.0, 5785.82642520725, 5799.18811366409, 5780.277465316835, 5786.913196302038, 5802.100674395476, 5821.0, 5861.0915308127305, 5788.247527821377, 5820.796272130477, 5822.359540450547, 5843.2695913010875, 5860.853478663025, 5557.944420555783, 5830.591858569902, 5883.058710606304, 5908.67502287374, 5915.763369465216, 5624.437556244384, 5641.774329026875, 5674.2623458950075, 5727.4845263926445, 5790.392008839053, 6323.114763933053, 6340.112384266206, 6392.041193820917, 6414.358564143595, 6423.100765892778, 6604.570702904296, 6709.36261055199, 6709.832254193635, 6768.6615669216835, 6823.351781580792, 6816.182058153004, 6852.725890964355, 6855.725770969155, 6858.897116543206, 6872.175338959307, 6250.249970003583, 6316.147320111772, 6354.0, 6366.267879193906, 6366.331535188831, 6963.373296403348, 6981.0924579804305, 7024.367806897404, 7055.329743674342, 7061.152661680631, 6451.258105317855, 6583.670816459254, 6619.900701489481, 6630.370114839179, 6719.0593316935665, 6749.156355455568, 6807.727690892309, 6837.0, 6838.589684618939, 6839.863202735917, 6777.559458635173, 6793.388595026471, 6802.65986700663, 6802.761903333359, 6830.965845170742, 6696.665166741644, 6773.288804675537, 6776.322367763184, 6778.966105169443, 6784.321567843275, 5280.841574752687, 5285.656432331886, 5347.545458636059, 5379.273798037293, 5380.085385484477, 4558.475775285885, 4580.587747102777, 4609.078184363141, 4659.068186362741, 4683.6721429500285, 5813.09896965971, 5819.447152520504, 5819.88360232793, 5822.301323841166, 5828.12578113278, 6802.693878775467, 6844.486663500158, 6893.724251029903, 6899.75850845218, 6903.0, 5801.390853960358, 5803.100519419497, 5864.0, 5867.559933005042, 5869.765209391577, 5700.287464066992, 5769.798057067983, 5799.159121927381, 5834.183214349994, 5886.087656413263, 6552.901706474407, 6553.508486863504, 6554.3117972613145, 6561.311062338385, 6604.801855944329, 6754.952982287753, 6787.0, 6842.213145488233, 6857.177138743383, 6860.931390686129, 6451.161349024596, 6491.058796474579, 6572.507061970276, 6579.901301480578, 6613.404793568602, 6510.088587597835, 6600.075989361397, 6606.6366349849295, 6649.135612370361, 6736.5958042517605, 6701.966490167518, 6713.731450741916, 6734.225564060196, 6736.93263067363, 6756.560823546453, 6446.709898054505, 6567.113439685581, 6657.53397262187, 6663.933360666525, 6668.233153187445, 6582.440492557995, 6673.0, 6673.065770791996, 6691.130153080068, 6699.095622090956, 6502.772402965874, 6509.316521765336, 6588.341165883373, 6607.504437167136, 6609.3060228675295, 6470.158879345655, 6481.351864813481, 6553.475721942138, 6622.238442579165, 6628.138342015507, 6351.079093531504, 6359.300476947439, 6366.6180029198395, 6382.585131966407, 6383.265924418565], "value": 6160.17069005125, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [826.2687521543432, 840.2311884625568, 856.9442986205896, 884.9336299777518, 890.0432035561772, 40485.39271910924, 41577.58422415775, 41694.37458438122, 41697.7915110424, 41742.791286043524, 37348.813255933754, 37684.43473347902, 37700.43449348255, 37747.81126094372, 37777.622223777755, 7061.682224299919, 7145.1068616422945, 7169.426445884316, 7169.641517924083, 7173.60545170018, 6952.304769523058, 7091.609961452118, 7093.609851458168, 7094.148702155749, 7096.645167741618, 6789.219239787413, 6884.759033433831, 7086.149662040562, 7094.85810283794, 7121.715131394738, 6804.047433359334, 6851.040854280404, 6853.383195512428, 6859.525202081576, 6867.828304292408, 7703.922960770433, 7792.493487923323, 7800.0, 7800.18098099697, 7800.219978002211, 38155.809220954, 38620.80689596562, 38841.611583884085, 38908.22183556313, 39016.0, 3492.2317090240363, 3539.0975301298004, 3539.8938031859084, 3540.982295088508, 3541.1678255609913, 31940.680593194003, 32052.519212211835, 32106.357872842647, 32108.839455802805, 32123.678763212538, 5190.299309593194, 5198.5061419165495, 5215.713135777531, 5219.086659834514, 5242.318498595197, 184243.0, 184438.07780961008, 184927.0, 185126.0, 185465.0, 48517.514824852005, 48531.514684853406, 48612.27081593779, 48644.27033594499, 48711.512884870695, 49751.502484974684, 49894.50105498971, 50023.9995200094, 50064.49935500598, 50253.0, 15920.442784502718, 16153.4346297879, 16347.18264086791, 16385.50843474698, 16396.26216820246, 13371.531996380274, 13402.06185567001, 13408.19550826934, 13408.865911340958, 13413.061085723906, 14263.572092837232, 14355.712885742436, 14403.279836008158, 14491.130532168103, 14497.927510362591, 5724.427557244242, 5753.424657534213, 5853.473187413153, 5878.911816322759, 5886.381929897299, 971.8639390485338, 1005.492226425665, 1005.8742657167854, 1009.3287963504188, 1010.888802231754, 21936.561268774854, 22381.216657416913, 22404.655720656814, 22425.215117471136, 22567.887160564092, 1097.6706987903597, 1102.9889701103048, 1106.3693694594165, 1106.8229083346625, 1106.882049130384, 11697.473613687405, 11989.340586267665, 12036.939815300868, 12062.939685301517, 12075.516979320904, 219867.0, 220776.0, 221510.0, 221816.0, 222159.0, 52482.737586312585, 52707.472925271024, 52898.0, 53111.0, 55791.0, 1407.7466056109793, 1425.0523401937596, 1444.7543917534044, 1446.7323545144181, 1453.0409929446514, 26635.60046599341, 26774.732252678004, 26899.596506052818, 27208.11675329884, 27367.726322737315, 37034.44448333331, 37353.62646373502, 37369.25261494809, 37434.25131497409, 37450.0, 207124.0, 208452.0, 208659.0, 208950.0, 210442.0, 34950.47574286337, 35024.474632881036, 35069.82465087658, 35076.29847402986, 35107.82446087855, 41892.79053604713, 43056.138877222904, 43520.78239608908, 43626.0, 43842.123157536036, 31472.0, 31647.52528712025, 31826.0, 32263.0, 32432.83783581067, 31456.528152078194, 31517.36965260636, 31569.21076973094, 31721.5241771369, 32416.35167296594, 33820.3235935275, 35012.47481287834, 35070.47394289036, 35258.471122932664, 35481.64518354887, 31149.221269468446, 31446.0, 31583.526247105852, 31632.525512116878, 31701.682983169874, 22851.31446056621, 22943.0, 23152.35064688946, 23282.0, 23656.29031129069], "value": 16994.09156575821, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [547.4580165636019, 561.9297587801525, 569.8945695046414, 585.3911931591146, 585.7042193692183, 21690.566188676217, 22439.887800561017, 22443.438914027138, 22447.326580202578, 22544.66183007252, 23621.0, 24390.14634487789, 24746.13388531402, 25282.747172528314, 25598.23205303839, 6439.774607888713, 6507.186601674791, 6520.282768895418, 6524.282328943812, 6534.411902928736, 5969.403059694039, 6446.935530644704, 6544.443722283611, 6550.312217217172, 6554.508411869105, 6133.539984501181, 6185.350538193492, 6193.752249909998, 6199.380061993809, 6212.0, 6177.258728952532, 6207.068939659065, 6213.254409470847, 6222.751089956397, 6234.906476402857, 5840.299164100293, 6065.666388348639, 6136.9079463808075, 6140.293866205398, 6144.600600960924, 28349.14952551406, 28720.71279287201, 28850.134495965154, 28876.989305374213, 28883.56674649882, 2012.4566367080806, 2038.6840039793856, 2041.020310251073, 2046.9181232750673, 2047.6518991771286, 18870.811291887043, 19237.422877313704, 19437.22251109954, 19960.600787984305, 20065.598688026304, 2424.8908799104083, 2435.5250726108416, 2496.251124662594, 2497.225859983411, 2498.3254521279337, 115614.42192788982, 119318.0, 120402.0, 129704.35147824296, 135174.0, 14690.711343916182, 14695.044822086531, 14740.557783266519, 14835.554933352018, 14860.433495961108, 22510.77489225087, 22563.0, 22601.0, 22612.773872261067, 22637.0, 10126.13927816144, 10271.0, 10289.43408112546, 10379.325343852626, 10411.53148108337, 9647.1317581418, 9695.854562181574, 9730.854037189449, 9766.121049105615, 9782.461964591874, 8816.250618697355, 8843.46939183651, 8914.509701966324, 8989.55052247385, 9084.454932704059, 2535.9492810143693, 2546.2106746908516, 2610.464854704819, 2611.9477610447684, 2709.078913169532, 892.6652505310509, 926.41832956438, 943.6036864516782, 945.3666043750703, 947.6162154327509, 19000.144993475325, 19170.90414547946, 19565.51086222856, 19707.507312317306, 19778.10998505071, 982.4891056650501, 990.0990099009866, 993.8012397520525, 998.4907697074544, 999.160705007797, 10776.191785615953, 10791.6222932197, 10825.350478971286, 10919.617813376493, 11079.224454288122, 498455.0, 502041.0, 502563.0, 508375.0, 512970.0, 110670.44664776625, 110943.0, 110989.44505277583, 112850.43574782074, 114357.42821286006, 1019.2050200843354, 1053.9209559283083, 1111.3554138599593, 1123.4888125902694, 1162.3607016141088, 20527.897360513103, 20793.480162996046, 20845.270415535382, 20938.895305523376, 20956.790432096095, 54343.184852226455, 54846.72576637251, 55230.72384638051, 55577.0, 56929.430705692415, 68266.65866670635, 68537.0, 70262.0, 70525.29474705187, 70527.0, 14151.64620884445, 14251.64370890736, 14452.421903124177, 14455.13269203851, 14463.85536144625, 22636.434089147904, 22737.431564211027, 22932.885335573217, 23016.19443319543, 23304.184353547545, 17384.565385865455, 18228.72656910174, 18379.72430413518, 18611.720824187378, 18633.161507731915, 15802.0, 16021.118838463997, 16178.919105404397, 16935.57661058434, 16996.405125820536, 18444.07779611041, 18659.906700466952, 18811.0, 18893.338733144275, 18980.240790368232, 13919.582412527641, 13980.650483737987, 14113.01208915366, 14158.858411415755, 14163.858361416254, 17944.282228710705, 17987.550311242325, 18342.17460214267, 18371.90814045921, 18394.0], "value": 11796.591864906259, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1310.6264714556353, 1340.6380277325122, 1350.230368689847, 1372.812517172646, 1377.3388773388774, 12574.81137782934, 13184.34078296085, 13204.933975330134, 13222.07445478817, 15181.696366072672, 14964.176970266632, 15224.0, 15253.771193432107, 15257.465988690397, 15354.232288385563, 2768.3632764464187, 2835.3053501891964, 2853.514902466575, 2855.828650280979, 2858.585505101759, 2639.3401649587604, 2735.3298441881766, 2845.701201373857, 2848.117083704048, 2870.2537340291465, 2837.6027356170152, 2879.942401151976, 2882.279430142464, 2883.1638824740903, 2884.033848660701, 2705.337192387858, 2755.5453350197195, 2772.8059035867495, 2824.2798086487815, 2832.1786681862236, 2436.0, 2485.7017157941164, 2488.4525404411183, 2488.8631125288102, 2505.6366826810195, 14602.780958285528, 14879.0, 14890.255487225704, 14964.625884352869, 14981.850181498154, 7966.203379662045, 8237.46456480333, 8237.629306681214, 8240.093589705128, 8259.42184047117, 5576.33084029915, 5662.292213473316, 5707.6290041147195, 5805.651660900317, 5850.590458667895, 1903.3623736048442, 1913.6842421000517, 1914.301280032792, 1957.5204075001573, 1964.1750464804672, 26150.34624134393, 26420.47159056827, 26436.471270574482, 26452.73547264522, 26511.867440662867, 6666.566673166229, 6698.425869920565, 6850.0, 6952.965235173893, 7060.082189315356, 16756.6648667026, 16861.0, 16879.0, 16879.915600422166, 16885.83114168867, 8083.272505474535, 8088.0, 8089.0, 8111.1888811118415, 8113.188681131957, 7365.3739432147795, 7494.737684181027, 7497.962510187524, 7549.2073332300415, 7556.546607203585, 5116.053530096944, 5195.896082078338, 5275.287836142072, 5307.336582927134, 5309.256704061435, 1384.6330722358382, 1391.3460673483446, 1410.7037522120265, 1424.7915730617708, 1458.2635768936618, 867.1328671328671, 888.9866652000096, 893.115815342806, 897.6947837735202, 911.996803516127, 7237.782866514013, 7298.051253337032, 7326.780196594111, 7378.889316660255, 7440.66517006736, 945.4894357047117, 997.1324947295899, 997.217184510156, 1005.8742657167854, 1009.1220638044948, 4234.915301693949, 4445.488768791565, 4449.666275029385, 4453.131639330364, 4484.8430304939175, 21542.35372938814, 21706.13175472995, 22021.889890550767, 22258.109675612795, 22540.21109261168, 21887.452813679785, 21990.780092199195, 22034.33896983093, 22156.778432215793, 22252.88873555622, 9236.214921731727, 9718.173955213744, 9818.312718109806, 9822.901770982342, 9847.852282215628, 9024.774380640536, 9064.093590640883, 9125.17873391398, 9193.310501712265, 9247.76880577991, 18674.0, 18765.624687506446, 18773.436796896116, 18786.436406907815, 19001.33495327712, 19174.61650767005, 19182.616347673247, 19474.123664435418, 19512.707309390655, 19829.702554461983, 12048.457819397972, 12351.444185011876, 12379.504819807467, 12404.19372740769, 12416.192947458387, 13920.791188132389, 13962.79055814184, 14008.369623367176, 14059.0, 14085.366158522686, 10756.515956781806, 10834.837477437686, 10988.780224395627, 11078.889211108108, 11282.153838462313, 11120.054795342163, 11149.665510034387, 11156.44217789091, 11453.59912403062, 11558.537658493902, 9705.757356065873, 9778.511074446107, 9836.655717049869, 9893.554790034323, 9921.950390248003, 6749.493787965824, 6867.3476019778045, 6922.065521154781, 6965.33829286217, 7018.192907815463, 7025.402840758593, 7115.928840711526, 7237.3486386223385, 7250.746223882139, 7311.963440182765], "value": 6629.757366093735, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [497.07295893159244, 510.25248011662916, 523.9808572326826, 527.1697077103562, 533.810497273468, 6369.821583007141, 6431.903521447176, 6441.83895402614, 6492.318306577812, 6493.772717954873, 6189.628622282667, 6294.402031806982, 6312.612734149768, 6346.270178929424, 6352.745890164388, 4892.902141957159, 5009.849704508871, 5048.671836330645, 5052.9242061369105, 5059.721715305675, 5049.293098966147, 5097.158968770148, 5108.208227724708, 5132.255822905677, 5133.383993920735, 5016.172331565287, 5031.4465408805, 5031.6729412588065, 5058.772355244005, 5102.311187989611, 5018.824341148043, 5035.733919736115, 5066.36670416198, 5091.592672586185, 5093.236014597822, 4539.909201815978, 4552.1350943320995, 4560.566746159109, 4578.313253012042, 4578.679492435531, 6292.968535157295, 6309.116723658692, 6315.463185629227, 6337.732453509317, 6346.0798184263485, 5778.42215778423, 5785.17766903424, 5796.362400135981, 5819.563532735062, 5858.150568167592, 6622.6357550334715, 6628.602283862983, 6662.833429164261, 6704.865902681919, 6778.118844550227, 4896.485868983741, 4921.138800709861, 4934.80260789568, 4953.968872762186, 4955.306257124005, 6974.0, 7057.470689698293, 7081.256468070881, 7093.929060709378, 7107.786766397016, 5023.49765023502, 5031.4465408805, 5031.823886163967, 5037.949620503821, 5058.797648094035, 5107.82917260163, 5113.463086375951, 5132.178851383761, 5133.281340612317, 5161.664491808096, 5787.768489260382, 5788.623739456922, 5789.739461724148, 5797.36229014808, 5810.1865738796605, 6385.0, 6559.901601475886, 6623.238327592292, 6677.899831502435, 6757.763478278237, 1671.2729962466124, 1728.6629107324202, 1736.097229440709, 1759.7096479081065, 1772.3619496981075, 1205.300526257972, 1210.0803389424102, 1214.1682947181032, 1217.2392254840724, 1220.5544976083843, 5710.428957104256, 5722.456366645162, 5728.455796699307, 5793.188953546507, 5822.33043200029, 6692.4903161314505, 6803.387695107365, 6855.806142034601, 6857.7256909723055, 6936.687849046805, 5804.868050730067, 5827.921834460553, 5829.143719577377, 5844.590878638454, 5869.911951320733, 3586.4261718124976, 3611.205534782344, 3612.223371975038, 3616.6383361663625, 3618.819059047037, 6670.566413183127, 6689.264180940093, 6696.799096027127, 6698.83252918681, 6702.296258892844, 7071.92928070723, 7108.573485590881, 7124.46566507514, 7125.42996560274, 7143.642817859086, 6490.707918143695, 6576.901346479806, 6600.669966501751, 6609.933900661124, 6610.636414997221, 6825.317468253135, 6877.931220687729, 6879.036934829028, 6895.55178913369, 6904.482163837632, 6747.797566072829, 6761.830954226184, 6801.693923773343, 6821.658917054227, 6900.378965893094, 6444.420002199825, 6533.314002029909, 6568.704408301543, 6572.507061970467, 6572.638504882278, 4943.797771893862, 4992.0, 4992.350994370709, 5004.324416203766, 5004.3994720633755, 6621.867562648624, 6826.556273842184, 6856.9314306856295, 6857.794266172023, 6864.279250678607, 6268.498520118471, 6435.195600549931, 6530.967345163243, 6664.200295964515, 6716.731330746911, 6507.089007539043, 6555.246146693191, 6602.570832895846, 6656.23453302857, 6671.466282697275, 6300.621962682254, 6372.206355229939, 6378.712957916812, 6446.967765161332, 6595.340465953366, 6542.574732642363, 6570.342965703391, 6615.636140012345, 6641.634710090798, 6687.966560167168, 6401.199850018747, 6438.227412710505, 6446.967765161145, 6501.05734668461, 6509.934900650933], "value": 5125.340190040805, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [884.3058199313532, 894.2711689972672, 918.912703293187, 919.7516670498966, 937.3110763588763, 16197.595060123487, 17030.31878724851, 17093.914530427344, 17113.0, 17186.742198866996, 15909.0, 16096.275667594957, 16281.511554653349, 16310.75533866993, 16601.916990415062, 966.6858271061916, 981.6858605246324, 987.7777500062465, 988.0810845913297, 989.5200827598609, 979.9706008819746, 983.8671779309773, 985.1183191044047, 985.2167526816198, 986.378581493658, 978.3493976505615, 1011.9645812396568, 1017.1252722658508, 1018.5365658625308, 1018.9592416303338, 997.0727223681973, 999.8100360931436, 1003.3528374198601, 1004.4023805835552, 1006.3760468509498, 715.4455297144702, 738.4314078159787, 746.5296862976345, 747.215423805008, 747.4618274842105, 17121.486355409357, 17266.22301996413, 17274.913625431916, 17284.39504617345, 17291.0, 21097.789022109737, 21139.47151321214, 21504.354869353945, 21527.892360538255, 21632.459188520257, 16867.397597228242, 17387.478375648752, 17446.21492032849, 17449.21478533469, 17540.473785786446, 3779.5842457329672, 3783.4324851272254, 3818.16000479894, 3818.236352729465, 3818.579956204815, 127512.36243818814, 129867.0, 131791.0, 133066.0, 135664.999999999, 16393.180340982904, 16574.83425165757, 16943.15284235783, 16986.915065424593, 16987.74518382225, 30431.543526847116, 30565.541516877263, 30648.846755766524, 30650.846745766576, 30664.080077597708, 8714.172153645393, 8870.068642792543, 8881.24509416694, 8885.02264750877, 8886.289096872235, 3996.7402118862183, 4073.714839961174, 4077.204945035749, 4084.4281800547947, 4093.3246014407887, 5422.837314880481, 5491.0, 5584.86037849057, 5619.4099619540175, 5632.211490391349, 1031.5461197073414, 1044.7492601775518, 1055.1295181475314, 1056.7410984308895, 1059.5285098131412, 664.3588936676034, 682.6518475577392, 683.4293365040247, 692.51869950384, 702.1854648607591, 11758.470868810924, 12191.817122743167, 12439.875601243872, 12590.937045314899, 12884.0, 677.1434135818193, 686.807693845724, 698.2075344484048, 700.6146619359332, 703.9472039596948, 5480.369757477862, 5511.751971161308, 5569.248151499496, 5612.242347283146, 5655.660660360391, 129962.0, 132776.0, 132966.0, 133418.0, 136571.31714341365, 82155.0, 102127.0, 108862.45568772264, 111845.0, 114670.0, 90796.54601727081, 91896.0, 93280.53359733158, 93423.53288233651, 93823.53088234515, 13057.347132643139, 13070.738585228431, 13136.934315328363, 13217.933910330386, 13298.601041968757, 42530.149397011264, 42710.35934461048, 43070.35394469148, 43811.34282985694, 44055.559444405146, 56708.71645641745, 56847.71576142093, 57019.0, 57571.42428575828, 57728.42271577231, 17184.484465466056, 17382.30470781205, 17414.912925435292, 17592.73610895863, 17662.735058974384, 20061.59876802485, 20395.0, 20421.0, 20497.2825951091, 20691.379258622266, 17756.3785267515, 17854.19656115452, 18254.0, 18411.079446027376, 18609.162587683317, 16837.66324673475, 17112.657746844743, 17244.396446124327, 17265.22306496236, 17336.65326693484, 17564.38524651631, 17581.736273956158, 17640.38258660941, 17745.911270443565, 17813.0, 12175.695607609881, 12180.208286461351, 12368.690782730504, 12646.05154613426, 12672.239665620093, 13519.459221631418, 13595.388207530883, 13712.108712933627, 13735.313234338044, 13754.174749515061], "value": 9058.891347774326, "unit": "score"}]}, {"extraOptions": ["e10s", "stylo_disabled"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1431.6, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 108.0, 109.0, 107.0, 108.0, 101.0, 110.0, 107.0, 107.0, 109.0], "value": 107.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 116.0, 118.0, 115.0, 121.0, 117.0, 116.0, 149.0, 121.0, 116.0], "value": 120.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 162.0, 163.0, 164.0, 162.0, 169.0, 165.0, 168.0, 165.0, 164.0], "value": 164.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 73.0, 78.0, 74.0, 75.0, 77.0, 153.0, 74.0, 77.0], "value": 82.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 79.0, 87.0, 79.0, 79.0, 78.0, 79.0, 79.0, 80.0, 78.0], "value": 79.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 114.0, 113.0, 110.0, 114.0, 113.0, 112.0, 113.0, 113.0, 114.0], "value": 112.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 149.0, 148.0, 148.0, 147.0, 148.0, 149.0, 149.0, 150.0, 150.0], "value": 148.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 94.0, 94.0, 98.0, 99.0, 94.0, 95.0, 94.0, 98.0], "value": 95.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 54.0, 53.0, 53.0, 52.0, 52.0, 54.0, 53.0, 55.0, 54.0], "value": 53.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [38.0, 38.0, 38.0, 38.0, 38.0, 38.0, 38.0, 38.0, 38.0, 38.0], "value": 38.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 75.0, 74.0, 74.0, 75.0, 75.0, 73.0, 78.0, 75.0, 73.0], "value": 74.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 111.0, 112.0, 116.0, 117.0, 123.0, 112.0, 113.0, 115.0, 110.0], "value": 113.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 174.0, 168.0, 172.0, 170.0, 168.0, 176.0, 173.0, 180.0, 171.0], "value": 172.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 65.0, 65.0, 73.0, 67.0, 68.0, 69.0, 66.0, 69.0, 68.0], "value": 67.6, "unit": "score"}]}]} 11:45:05 INFO - Return code: 0 11:45:05 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:45:05 INFO - # TBPL SUCCESS # 11:45:05 INFO - Running post-action listener: _package_coverage_data 11:45:05 INFO - Running post-action listener: _resource_record_post_action 11:45:05 INFO - [mozharness: 2017-09-15 18:45:05.879964Z] Finished run-tests step (success) 11:45:05 INFO - Running post-run listener: _resource_record_post_run 11:45:05 INFO - Total resource usage - Wall time: 1188s; CPU: 13.0%; Read bytes: 16384; Write bytes: 400297984; Read time: 220; Write time: 214024 11:45:05 INFO - TinderboxPrint: CPU usage
13.1% 11:45:05 INFO - TinderboxPrint: I/O read bytes / time
16,384 / 220 11:45:05 INFO - TinderboxPrint: I/O write bytes / time
400,297,984 / 214,024 11:45:05 INFO - TinderboxPrint: CPU idle
8,229.0 (86.9%) 11:45:05 INFO - TinderboxPrint: CPU user
1,194.3 (12.6%) 11:45:05 INFO - TinderboxPrint: Swap in / out
0 / 0 11:45:05 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 74346496; Read time: 0; Write time: 36480 11:45:05 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 11:45:05 INFO - run-tests - Wall time: 1171s; CPU: 13.0%; Read bytes: 12288; Write bytes: 325951488; Read time: 204; Write time: 177544 11:45:06 INFO - Running post-run listener: _upload_blobber_files 11:45:06 INFO - Blob upload gear active. 11:45:06 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:45:06 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 11:45:06 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'] 11:45:06 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 11:45:06 INFO - (blobuploader) - INFO - Open directory for files ... 11:45:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 11:45:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:45:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:45:08 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 11:45:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:45:08 INFO - (blobuploader) - INFO - Done attempting. 11:45:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log ... 11:45:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:45:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:45:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_raw.log: uploaded 11:45:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:45:09 INFO - (blobuploader) - INFO - Done attempting. 11:45:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:45:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:45:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:45:17 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:45:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:45:17 INFO - (blobuploader) - INFO - Done attempting. 11:45:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log ... 11:45:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:45:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:45:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_errorsummary.log: uploaded 11:45:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:45:18 INFO - (blobuploader) - INFO - Done attempting. 11:45:18 INFO - (blobuploader) - INFO - Iteration through files over. 11:45:18 INFO - Return code: 0 11:45:18 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:45:18 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:45:18 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/bf5023990e8446afe01fbc4d657c428a5d74aed946f183a4db20aa1cc4ecfc8f461be0d4e81c5befee1941c01d00c5da23f547b9c4f334f1cca94c6e2ff29a36", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9b80062fa5d77593c0ad827acaadb6da4bc14925485141b65d40eaa71fce142d425eae1d20302b571bf5ddcf9b9a85aa4f3610eeaeaa5d047cc61d70ff2a21d9", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/181fa717cfa5bf16f4fa55b0e7bee959235515e3923f331816139db8db90ae364946128c3349b832d50c65069786289aad0f242a69058b0a90099e060c7116ac", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b94e47b5c197c02b00425e04f3af542f9c29d16b0557b0ebd0a524337ddcd70b4c2c493b3f48452fb40da9be4c4bae155295167e1becff3f9c71beea41b1e58f"} 11:45:18 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:45:18 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:45:18 INFO - Contents: 11:45:18 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/bf5023990e8446afe01fbc4d657c428a5d74aed946f183a4db20aa1cc4ecfc8f461be0d4e81c5befee1941c01d00c5da23f547b9c4f334f1cca94c6e2ff29a36", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9b80062fa5d77593c0ad827acaadb6da4bc14925485141b65d40eaa71fce142d425eae1d20302b571bf5ddcf9b9a85aa4f3610eeaeaa5d047cc61d70ff2a21d9", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/181fa717cfa5bf16f4fa55b0e7bee959235515e3923f331816139db8db90ae364946128c3349b832d50c65069786289aad0f242a69058b0a90099e060c7116ac", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b94e47b5c197c02b00425e04f3af542f9c29d16b0557b0ebd0a524337ddcd70b4c2c493b3f48452fb40da9be4c4bae155295167e1becff3f9c71beea41b1e58f"} 11:45:18 INFO - Running post-run listener: copy_logs_to_upload_dir 11:45:18 INFO - Copying logs to upload dir... 11:45:18 INFO - mkdir: /builds/slave/test/build/upload/logs 11:45:18 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1238.534591 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2017-09-15 11:45:18.430595) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-15 11:45:18.438208) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=20e20d796406ba5117c4a6f1000001ba-1505497411.419713-283184589 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/bf5023990e8446afe01fbc4d657c428a5d74aed946f183a4db20aa1cc4ecfc8f461be0d4e81c5befee1941c01d00c5da23f547b9c4f334f1cca94c6e2ff29a36", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9b80062fa5d77593c0ad827acaadb6da4bc14925485141b65d40eaa71fce142d425eae1d20302b571bf5ddcf9b9a85aa4f3610eeaeaa5d047cc61d70ff2a21d9", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/181fa717cfa5bf16f4fa55b0e7bee959235515e3923f331816139db8db90ae364946128c3349b832d50c65069786289aad0f242a69058b0a90099e060c7116ac", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b94e47b5c197c02b00425e04f3af542f9c29d16b0557b0ebd0a524337ddcd70b4c2c493b3f48452fb40da9be4c4bae155295167e1becff3f9c71beea41b1e58f"} build_url:https://queue.taskcluster.net/v1/task/dGTWU5R0RMmqQFwWXFslJA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011384 build_url: 'https://queue.taskcluster.net/v1/task/dGTWU5R0RMmqQFwWXFslJA/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/bf5023990e8446afe01fbc4d657c428a5d74aed946f183a4db20aa1cc4ecfc8f461be0d4e81c5befee1941c01d00c5da23f547b9c4f334f1cca94c6e2ff29a36", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9b80062fa5d77593c0ad827acaadb6da4bc14925485141b65d40eaa71fce142d425eae1d20302b571bf5ddcf9b9a85aa4f3610eeaeaa5d047cc61d70ff2a21d9", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/181fa717cfa5bf16f4fa55b0e7bee959235515e3923f331816139db8db90ae364946128c3349b832d50c65069786289aad0f242a69058b0a90099e060c7116ac", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b94e47b5c197c02b00425e04f3af542f9c29d16b0557b0ebd0a524337ddcd70b4c2c493b3f48452fb40da9be4c4bae155295167e1becff3f9c71beea41b1e58f"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-15 11:45:18.469400) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-15 11:45:18.469793) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=20e20d796406ba5117c4a6f1000001ba-1505497411.419713-283184589 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004563 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-15 11:45:18.553114) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-15 11:45:18.553475) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-15 11:45:18.553915) ========= ========= Total master_lag: 0.29 =========