builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-047 starttime: 1502994294.88 results: success (0) revision: f53a37fc0e92c093bf48baada9f9adab16422cd7 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-08-17 11:24:54.883229) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-08-17 11:24:54.883699) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-17 11:24:54.883980) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-17 11:24:54.899721) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-17 11:24:54.899982) ========= 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=03627c79f6bb3d1578c4a402000001ba-1502994294.323044-408794288 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-08-17 11:24:55-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 45.8M=0s 2017-08-17 11:24:55 (45.8 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.316291 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-17 11:24:55.231491) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-17 11:24:55.231804) ========= 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=03627c79f6bb3d1578c4a402000001ba-1502994294.323044-408794288 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017413 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-17 11:24:55.281116) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-17 11:24:55.281454) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev f53a37fc0e92c093bf48baada9f9adab16422cd7 --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 f53a37fc0e92c093bf48baada9f9adab16422cd7 --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=03627c79f6bb3d1578c4a402000001ba-1502994294.323044-408794288 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-08-17 11:24:55,429 truncating revision to first 12 chars 2017-08-17 11:24:55,429 Setting DEBUG logging. 2017-08-17 11:24:55,429 attempt 1/10 2017-08-17 11:24:55,429 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/f53a37fc0e92?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-08-17 11:24:55,933 unpacking tar archive at: mozilla-central-f53a37fc0e92/testing/mozharness/ program finished with exit code 0 elapsedTime=0.830189 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-17 11:24:56.126068) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-17 11:24:56.126403) ========= script_repo_revision: f53a37fc0e92c093bf48baada9f9adab16422cd7 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-17 11:24:56.126786) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-17 11:24:56.127058) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-17 11:24:56.137639) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2017-08-17 11:24:56.138049) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=03627c79f6bb3d1578c4a402000001ba-1502994294.323044-408794288 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:24:56 INFO - MultiFileLogger online at 20170817 11:24:56 in /builds/slave/test 11:24:56 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 11:24:56 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:24:56 INFO - {'append_to_log': False, 11:24:56 INFO - 'base_work_dir': '/builds/slave/test', 11:24:56 INFO - 'blob_upload_branch': 'Firefox', 11:24:56 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:24:56 INFO - 'branch': 'Firefox', 11:24:56 INFO - 'buildbot_json_path': 'buildprops.json', 11:24:56 INFO - 'code_coverage': False, 11:24:56 INFO - 'config_files': ('talos/linux_config.py',), 11:24:56 INFO - 'default_actions': ('clobber', 11:24:56 INFO - 'read-buildbot-config', 11:24:56 INFO - 'download-and-extract', 11:24:56 INFO - 'populate-webroot', 11:24:56 INFO - 'create-virtualenv', 11:24:56 INFO - 'install', 11:24:56 INFO - 'setup-mitmproxy', 11:24:56 INFO - 'run-tests'), 11:24:56 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:24:56 INFO - 'disable_ccov_upload': False, 11:24:56 INFO - 'download_minidump_stackwalk': True, 11:24:56 INFO - 'download_symbols': 'ondemand', 11:24:56 INFO - 'enable_stylo': False, 11:24:56 INFO - 'enable_webrender': False, 11:24:56 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:24:56 INFO - 'tooltool.py': '/tools/tooltool.py', 11:24:56 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:24:56 INFO - '/tools/misc-python/virtualenv.py')}, 11:24:56 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:24:56 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:24:56 INFO - 'gecko_profile': False, 11:24:56 INFO - 'gecko_profile_interval': 0, 11:24:56 INFO - 'installer_path': 'installer.exe', 11:24:56 INFO - 'log_level': 'info', 11:24:56 INFO - 'log_name': 'talos', 11:24:56 INFO - 'log_to_console': True, 11:24:56 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:24:56 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:24:56 INFO - 'opt_config_files': (), 11:24:56 INFO - 'pip_index': False, 11:24:56 INFO - 'suite': 'dromaeojs-e10s', 11:24:56 INFO - 'system_bits': '32', 11:24:56 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:24:56 INFO - 'title': 'talos-linux64-ix-047', 11:24:56 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:24:56 INFO - 'use_talos_json': True, 11:24:56 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:24:56 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:24:56 INFO - 'work_dir': 'build'} 11:24:56 INFO - [mozharness: 2017-08-17 18:24:56.392465Z] Running clobber step. 11:24:56 INFO - Running pre-action listener: _resource_record_pre_action 11:24:56 INFO - Running main action method: clobber 11:24:56 INFO - rmtree: /builds/slave/test/build 11:24:56 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:24:57 INFO - Running post-action listener: _resource_record_post_action 11:24:57 INFO - [mozharness: 2017-08-17 18:24:57.515628Z] Finished clobber step (success) 11:24:57 INFO - [mozharness: 2017-08-17 18:24:57.515730Z] Running read-buildbot-config step. 11:24:57 INFO - Running pre-action listener: _resource_record_pre_action 11:24:57 INFO - Running main action method: read_buildbot_config 11:24:57 INFO - Using buildbot properties: 11:24:57 INFO - { 11:24:57 INFO - "project": "", 11:24:57 INFO - "product": "firefox", 11:24:57 INFO - "who": "ffxbld@noreply.mozilla.org", 11:24:57 INFO - "installer_path": "public/build/target.tar.bz2", 11:24:57 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 11:24:57 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 11:24:57 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 11:24:57 INFO - "stage_platform": "linux64-pgo", 11:24:57 INFO - "basedir": "/builds/slave/test", 11:24:57 INFO - "buildnumber": 125, 11:24:57 INFO - "platform": "ubuntu64_hw", 11:24:57 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 11:24:57 INFO - "slavebuilddir": "test", 11:24:57 INFO - "taskId": "LAFDYl0iTgSgL_4wBhTlZA", 11:24:57 INFO - "branch": "mozilla-central", 11:24:57 INFO - "script_repo_revision": "production", 11:24:57 INFO - "revision": "f53a37fc0e92c093bf48baada9f9adab16422cd7", 11:24:57 INFO - "slavename": "talos-linux64-ix-047", 11:24:57 INFO - "repo_path": "mozilla-central" 11:24:57 INFO - } 11:24:57 INFO - Finding installer, test and symbols from parent task. 11:24:57 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LAFDYl0iTgSgL_4wBhTlZA'}, attempt #1 11:24:57 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LAFDYl0iTgSgL_4wBhTlZA'}, attempt #1 11:24:58 INFO - Task dependencies: ej7oj6HVS_W6qwoEs3vqHQ 11:24:58 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ej7oj6HVS_W6qwoEs3vqHQ'}, attempt #1 11:24:58 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/ej7oj6HVS_W6qwoEs3vqHQ/artifacts/public/build/target.tar.bz2 11:24:58 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/ej7oj6HVS_W6qwoEs3vqHQ/artifacts/public/build/target.test_packages.json 11:24:58 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/ej7oj6HVS_W6qwoEs3vqHQ/artifacts/public/build/target.crashreporter-symbols.zip 11:24:58 INFO - Running post-action listener: _resource_record_post_action 11:24:58 INFO - [mozharness: 2017-08-17 18:24:58.886371Z] Finished read-buildbot-config step (success) 11:24:58 INFO - [mozharness: 2017-08-17 18:24:58.886591Z] Running download-and-extract step. 11:24:58 INFO - Running pre-action listener: _resource_record_pre_action 11:24:58 INFO - Running main action method: download_and_extract 11:24:58 INFO - mkdir: /builds/slave/test/build/tests 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 - trying https://queue.taskcluster.net/v1/task/ej7oj6HVS_W6qwoEs3vqHQ/artifacts/public/build/target.test_packages.json 11:24:58 INFO - Downloading https://queue.taskcluster.net/v1/task/ej7oj6HVS_W6qwoEs3vqHQ/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 11:24:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ej7oj6HVS_W6qwoEs3vqHQ/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 11:24:59 INFO - Downloaded 989 bytes. 11:24:59 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 11:24:59 INFO - Using the following test package requirements: 11:24:59 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 11:24:59 INFO - u'common': [u'target.common.tests.zip'], 11:24:59 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 11:24:59 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 11:24:59 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 11:24:59 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 11:24:59 INFO - u'mozbase': [u'target.common.tests.zip'], 11:24:59 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 11:24:59 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 11:24:59 INFO - u'web-platform': [u'target.common.tests.zip', 11:24:59 INFO - u'target.web-platform.tests.tar.gz'], 11:24:59 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 11:24:59 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 11:24:59 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ej7oj6HVS_W6qwoEs3vqHQ/artifacts/public/build/target.common.tests.zip 11:24:59 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ej7oj6HVS_W6qwoEs3vqHQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 11:24:59 INFO - Fetch https://queue.taskcluster.net/v1/task/ej7oj6HVS_W6qwoEs3vqHQ/artifacts/public/build/target.common.tests.zip into memory 11:25:00 INFO - Content-Length response header: 54608673 11:25:00 INFO - Bytes received: 54608673 11:25:11 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 11:25:11 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ej7oj6HVS_W6qwoEs3vqHQ/artifacts/public/build/target.common.tests.zip 11:25:11 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ej7oj6HVS_W6qwoEs3vqHQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 11:25:11 INFO - Fetch https://queue.taskcluster.net/v1/task/ej7oj6HVS_W6qwoEs3vqHQ/artifacts/public/build/target.common.tests.zip into memory 11:25:12 INFO - Content-Length response header: 54608673 11:25:12 INFO - Bytes received: 54608673 11:25:24 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ej7oj6HVS_W6qwoEs3vqHQ/artifacts/public/build/target.talos.tests.zip 11:25:24 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ej7oj6HVS_W6qwoEs3vqHQ/artifacts/public/build/target.talos.tests.zip'}, attempt #1 11:25:24 INFO - Fetch https://queue.taskcluster.net/v1/task/ej7oj6HVS_W6qwoEs3vqHQ/artifacts/public/build/target.talos.tests.zip into memory 11:25:25 INFO - Content-Length response header: 14496161 11:25:25 INFO - Bytes received: 14496161 11:25:25 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:25 INFO - trying https://queue.taskcluster.net/v1/task/ej7oj6HVS_W6qwoEs3vqHQ/artifacts/public/build/target.tar.bz2 11:25:25 INFO - Downloading https://queue.taskcluster.net/v1/task/ej7oj6HVS_W6qwoEs3vqHQ/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 11:25:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ej7oj6HVS_W6qwoEs3vqHQ/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 11:25:26 INFO - Downloaded 62987528 bytes. 11:25:26 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ej7oj6HVS_W6qwoEs3vqHQ/artifacts/public/build/target.tar.bz2 11:25:26 INFO - mkdir: /builds/slave/test/properties 11:25:26 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:25:26 INFO - Writing to file /builds/slave/test/properties/build_url 11:25:26 INFO - Contents: 11:25:26 INFO - build_url:https://queue.taskcluster.net/v1/task/ej7oj6HVS_W6qwoEs3vqHQ/artifacts/public/build/target.tar.bz2 11:25:26 INFO - Running post-action listener: _resource_record_post_action 11:25:26 INFO - Running post-action listener: set_extra_try_arguments 11:25:26 INFO - [mozharness: 2017-08-17 18:25:26.841433Z] Finished download-and-extract step (success) 11:25:26 INFO - [mozharness: 2017-08-17 18:25:26.841532Z] Running populate-webroot step. 11:25:26 INFO - Running pre-action listener: _resource_record_pre_action 11:25:26 INFO - Running main action method: populate_webroot 11:25:26 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:25:26 INFO - 'chromez-stylo-e10s': {'talos_options': ['--stylo'], 11:25:26 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:25:26 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:25:26 INFO - 'dromaeojs-stylo-e10s': {'talos_options': ['--stylo'], 11:25:26 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:25:26 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 11:25:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:25:26 INFO - 'g1-stylo-e10s': {'pagesets_name': 'tp5n.zip', 11:25:26 INFO - 'talos_options': ['--stylo'], 11:25:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:25:26 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 11:25:26 INFO - 'tests': ['damp', 'tps']}, 11:25:26 INFO - 'g2-stylo-e10s': {'pagesets_name': 'tp5n.zip', 11:25:26 INFO - 'talos_options': ['--stylo'], 11:25:26 INFO - 'tests': ['damp', 'tps']}, 11:25:26 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:25:26 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 11:25:26 INFO - 'g4-stylo-e10s': {'talos_options': ['--stylo'], 11:25:26 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 11:25:26 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 11:25:26 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 11:25:26 INFO - 'g5-stylo-e10s': {'pagesets_name': 'tp5n.zip', 11:25:26 INFO - 'talos_options': ['--stylo'], 11:25:26 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 11:25:26 INFO - 'other-e10s': {'tests': ['a11yr', 11:25:26 INFO - 'ts_paint', 11:25:26 INFO - 'tpaint', 11:25:26 INFO - 'sessionrestore', 11:25:26 INFO - 'sessionrestore_many_windows', 11:25:26 INFO - 'sessionrestore_no_auto_restore', 11:25:26 INFO - 'tabpaint']}, 11:25:26 INFO - 'other-stylo-e10s': {'talos_options': ['--stylo'], 11:25:26 INFO - 'tests': ['a11yr', 11:25:26 INFO - 'ts_paint', 11:25:26 INFO - 'tpaint', 11:25:26 INFO - 'sessionrestore', 11:25:26 INFO - 'sessionrestore_many_windows', 11:25:26 INFO - 'sessionrestore_no_auto_restore', 11:25:26 INFO - 'tabpaint']}, 11:25:26 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 11:25:26 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 11:25:26 INFO - 'perf-reftest-singletons-stylo-e10s': {'talos_options': ['--stylo'], 11:25:26 INFO - 'tests': ['bloom_basic_singleton']}, 11:25:26 INFO - 'perf-reftest-stylo-e10s': {'talos_options': ['--stylo'], 11:25:26 INFO - 'tests': ['bloom_basic']}, 11:25:26 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:25:26 INFO - 'tsvgr_opacity', 11:25:26 INFO - 'tart', 11:25:26 INFO - 'tscrollx', 11:25:26 INFO - 'tsvg_static']}, 11:25:26 INFO - 'svgr-stylo-e10s': {'talos_options': ['--stylo'], 11:25:26 INFO - 'tests': ['tsvgx', 11:25:26 INFO - 'tsvgr_opacity', 11:25:26 INFO - 'tart', 11:25:26 INFO - 'tscrollx', 11:25:26 INFO - 'tsvg_static']}, 11:25:26 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 11:25:26 INFO - 'tp5o-stylo-e10s': {'pagesets_name': 'tp5n.zip', 11:25:26 INFO - 'talos_options': ['--stylo'], 11:25:26 INFO - 'tests': ['tp5o']}, 11:25:26 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:25:26 INFO - 'talos_options': ['--mitmproxy', 11:25:26 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:25:26 INFO - '--firstNonBlankPaint'], 11:25:26 INFO - 'tests': ['tp6_google', 11:25:26 INFO - 'tp6_youtube', 11:25:26 INFO - 'tp6_amazon', 11:25:26 INFO - 'tp6_facebook']}, 11:25:26 INFO - 'tp6-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:25:26 INFO - 'talos_options': ['--stylo', 11:25:26 INFO - '--mitmproxy', 11:25:26 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:25:26 INFO - '--firstNonBlankPaint'], 11:25:26 INFO - 'tests': ['tp6_google', 11:25:26 INFO - 'tp6_youtube', 11:25:26 INFO - 'tp6_amazon', 11:25:26 INFO - 'tp6_facebook']}, 11:25:26 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:25:26 INFO - 'talos_options': ['--stylo', 11:25:26 INFO - '--stylo-threads=1', 11:25:26 INFO - '--mitmproxy', 11:25:26 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:25:26 INFO - '--firstNonBlankPaint'], 11:25:26 INFO - 'tests': ['tp6_google', 11:25:26 INFO - 'tp6_youtube', 11:25:26 INFO - 'tp6_amazon', 11:25:26 INFO - 'tp6_facebook']}, 11:25:26 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 11:25:26 INFO - 'talos_options': ['--xperf_path', 11:25:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:25:26 INFO - 'tests': ['tp5n']}, 11:25:26 INFO - 'xperf-stylo-e10s': {'pagesets_name': 'tp5n.zip', 11:25:26 INFO - 'talos_options': ['--stylo', 11:25:26 INFO - '--xperf_path', 11:25:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:25:26 INFO - 'tests': ['tp5n']}}} 11:25:26 INFO - Running post-action listener: _resource_record_post_action 11:25:26 INFO - [mozharness: 2017-08-17 18:25:26.855762Z] Finished populate-webroot step (success) 11:25:26 INFO - [mozharness: 2017-08-17 18:25:26.855853Z] Running create-virtualenv step. 11:25:26 INFO - Running pre-action listener: _resource_record_pre_action 11:25:26 INFO - Running main action method: create_virtualenv 11:25:26 INFO - Creating virtualenv /builds/slave/test/build/venv 11:25:26 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 11:25:26 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:25:26 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 11:25:26 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:25:26 INFO - Using real prefix '/usr' 11:25:26 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:25:27 INFO - Installing distribute.............................................................................................................................................................................................done. 11:25:29 INFO - Installing pip.................done. 11:25:29 INFO - Return code: 0 11:25:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 11:25:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 11:25:29 INFO - Reading from file tmpfile_stdout 11:25:29 INFO - Output received: 11:25:29 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 11:25:29 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:25:29 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:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:25:29 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:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:25:29 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 0x1ec51f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fc9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x216cef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x216a0b0>, '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 0x216afb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x216b440>, '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': '03627c79f6bb3d1578c4a402000001ba-1502994294.323044-408794288', '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:29 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:25:29 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:25:29 INFO - Using env: {'DISPLAY': ':0', 11:25:29 INFO - 'HOME': '/home/cltbld', 11:25:29 INFO - 'LANG': 'en_US.UTF-8', 11:25:29 INFO - 'LANGUAGE': 'en_US:en', 11:25:29 INFO - 'LOGNAME': 'cltbld', 11:25:29 INFO - 'MAIL': '/var/mail/cltbld', 11:25:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:25:29 INFO - 'MOZ_NO_REMOTE': '1', 11:25:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:25:29 INFO - 'NO_EM_RESTART': '1', 11:25:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:25:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:25:29 INFO - 'PWD': '/builds/slave/test', 11:25:29 INFO - 'SHELL': '/bin/bash', 11:25:29 INFO - 'SHLVL': '1', 11:25:29 INFO - 'TERM': 'linux', 11:25:29 INFO - 'TMOUT': '86400', 11:25:29 INFO - 'USER': 'cltbld', 11:25:29 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1502994294.323044-408794288', 11:25:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:25:29 INFO - '_': '/tools/buildbot/bin/python'} 11:25:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:25:29 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 11:25:29 INFO - Cleaning up... 11:25:29 INFO - Return code: 0 11:25:29 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:25:29 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:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:25:29 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:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:25:29 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 0x1ec51f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fc9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x216cef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x216a0b0>, '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 0x216afb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x216b440>, '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': '03627c79f6bb3d1578c4a402000001ba-1502994294.323044-408794288', '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:29 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:29 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:29 INFO - Using env: {'DISPLAY': ':0', 11:25:29 INFO - 'HOME': '/home/cltbld', 11:25:29 INFO - 'LANG': 'en_US.UTF-8', 11:25:29 INFO - 'LANGUAGE': 'en_US:en', 11:25:29 INFO - 'LOGNAME': 'cltbld', 11:25:29 INFO - 'MAIL': '/var/mail/cltbld', 11:25:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:25:29 INFO - 'MOZ_NO_REMOTE': '1', 11:25:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:25:29 INFO - 'NO_EM_RESTART': '1', 11:25:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:25:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:25:29 INFO - 'PWD': '/builds/slave/test', 11:25:29 INFO - 'SHELL': '/bin/bash', 11:25:29 INFO - 'SHLVL': '1', 11:25:29 INFO - 'TERM': 'linux', 11:25:29 INFO - 'TMOUT': '86400', 11:25:29 INFO - 'USER': 'cltbld', 11:25:29 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1502994294.323044-408794288', 11:25:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:25:29 INFO - '_': '/tools/buildbot/bin/python'} 11:25:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:25:30 INFO - Downloading/unpacking psutil>=3.1.1 11:25:30 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:30 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:30 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:30 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:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:25:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:25:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:25:31 INFO - Installing collected packages: psutil 11:25:31 INFO - Running setup.py install for psutil 11:25:31 INFO - building 'psutil._psutil_linux' extension 11:25:31 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:31 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:31 INFO - building 'psutil._psutil_posix' extension 11:25:31 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:31 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:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:25:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:25:31 INFO - Successfully installed psutil 11:25:31 INFO - Cleaning up... 11:25:31 INFO - Return code: 0 11:25:31 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:25:31 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:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:25:31 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:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:25:31 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 0x1ec51f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fc9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x216cef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x216a0b0>, '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 0x216afb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x216b440>, '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': '03627c79f6bb3d1578c4a402000001ba-1502994294.323044-408794288', '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:31 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:31 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:31 INFO - Using env: {'DISPLAY': ':0', 11:25:31 INFO - 'HOME': '/home/cltbld', 11:25:31 INFO - 'LANG': 'en_US.UTF-8', 11:25:31 INFO - 'LANGUAGE': 'en_US:en', 11:25:31 INFO - 'LOGNAME': 'cltbld', 11:25:31 INFO - 'MAIL': '/var/mail/cltbld', 11:25:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:25:31 INFO - 'MOZ_NO_REMOTE': '1', 11:25:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:25:31 INFO - 'NO_EM_RESTART': '1', 11:25:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:25:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:25:31 INFO - 'PWD': '/builds/slave/test', 11:25:31 INFO - 'SHELL': '/bin/bash', 11:25:31 INFO - 'SHLVL': '1', 11:25:31 INFO - 'TERM': 'linux', 11:25:31 INFO - 'TMOUT': '86400', 11:25:31 INFO - 'USER': 'cltbld', 11:25:31 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1502994294.323044-408794288', 11:25:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:25:31 INFO - '_': '/tools/buildbot/bin/python'} 11:25:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:25:32 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:25:32 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:32 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:32 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:32 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:33 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:25:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:25:33 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:33 INFO - Installing collected packages: mozsystemmonitor 11:25:33 INFO - Running setup.py install for mozsystemmonitor 11:25:33 INFO - Successfully installed mozsystemmonitor 11:25:33 INFO - Cleaning up... 11:25:33 INFO - Return code: 0 11:25:33 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:25:33 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:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:25:33 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:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:25:33 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 0x1ec51f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fc9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x216cef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x216a0b0>, '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 0x216afb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x216b440>, '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': '03627c79f6bb3d1578c4a402000001ba-1502994294.323044-408794288', '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:33 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:33 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:33 INFO - Using env: {'DISPLAY': ':0', 11:25:33 INFO - 'HOME': '/home/cltbld', 11:25:33 INFO - 'LANG': 'en_US.UTF-8', 11:25:33 INFO - 'LANGUAGE': 'en_US:en', 11:25:33 INFO - 'LOGNAME': 'cltbld', 11:25:33 INFO - 'MAIL': '/var/mail/cltbld', 11:25:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:25:33 INFO - 'MOZ_NO_REMOTE': '1', 11:25:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:25:33 INFO - 'NO_EM_RESTART': '1', 11:25:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:25:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:25:33 INFO - 'PWD': '/builds/slave/test', 11:25:33 INFO - 'SHELL': '/bin/bash', 11:25:33 INFO - 'SHLVL': '1', 11:25:33 INFO - 'TERM': 'linux', 11:25:33 INFO - 'TMOUT': '86400', 11:25:33 INFO - 'USER': 'cltbld', 11:25:33 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1502994294.323044-408794288', 11:25:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:25:33 INFO - '_': '/tools/buildbot/bin/python'} 11:25:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:25:33 INFO - Downloading/unpacking jsonschema==2.5.1 11:25:33 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:33 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:33 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:33 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:34 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:25:34 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:25:34 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:34 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:34 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:34 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:34 INFO - Downloading functools32-3.2.3-2.tar.gz 11:25:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:25:34 INFO - warning: no files found matching '*.txt' 11:25:34 INFO - no previously-included directories found matching 'build' 11:25:34 INFO - no previously-included directories found matching 'dist' 11:25:34 INFO - no previously-included directories found matching '.git*' 11:25:34 INFO - Installing collected packages: jsonschema, functools32 11:25:34 INFO - Running setup.py install for functools32 11:25:34 INFO - warning: no files found matching '*.txt' 11:25:34 INFO - no previously-included directories found matching 'build' 11:25:34 INFO - no previously-included directories found matching 'dist' 11:25:34 INFO - no previously-included directories found matching '.git*' 11:25:34 INFO - Successfully installed jsonschema functools32 11:25:34 INFO - Cleaning up... 11:25:35 INFO - Return code: 0 11:25:35 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 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 - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 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 - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:25:35 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 0x1ec51f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fc9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x216cef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x216a0b0>, '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 0x216afb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x216b440>, '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': '03627c79f6bb3d1578c4a402000001ba-1502994294.323044-408794288', '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:35 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:35 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: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 - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:25:35 INFO - 'MOZ_NO_REMOTE': '1', 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': '/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 - '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': '03627c79f6bb3d1578c4a402000001ba-1502994294.323044-408794288', 11:25:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:25:35 INFO - '_': '/tools/buildbot/bin/python'} 11:25:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:25:35 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 11:25:35 INFO - Cleaning up... 11:25:35 INFO - Return code: 0 11:25:35 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 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 - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 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 - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:25:35 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 0x1ec51f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fc9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x216cef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x216a0b0>, '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 0x216afb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x216b440>, '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': '03627c79f6bb3d1578c4a402000001ba-1502994294.323044-408794288', '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:35 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:35 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: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 - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:25:35 INFO - 'MOZ_NO_REMOTE': '1', 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': '/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 - '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': '03627c79f6bb3d1578c4a402000001ba-1502994294.323044-408794288', 11:25:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:25:35 INFO - '_': '/tools/buildbot/bin/python'} 11:25:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:25:35 INFO - Downloading/unpacking blobuploader==1.2.4 11:25:35 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:35 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:35 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:35 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:36 INFO - Downloading blobuploader-1.2.4.tar.gz 11:25:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:25:36 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:25:36 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:36 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:36 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:36 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:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:25:36 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:25:36 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:36 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:36 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:36 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:37 INFO - Downloading docopt-0.6.1.tar.gz 11:25:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:25:37 INFO - Installing collected packages: blobuploader, requests, docopt 11:25:37 INFO - Running setup.py install for blobuploader 11:25:37 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:25:37 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:25:37 INFO - Running setup.py install for requests 11:25:37 INFO - Running setup.py install for docopt 11:25:37 INFO - Successfully installed blobuploader requests docopt 11:25:37 INFO - Cleaning up... 11:25:37 INFO - Return code: 0 11:25:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:25:37 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:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:25:37 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:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:25:37 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 0x1ec51f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fc9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x216cef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x216a0b0>, '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 0x216afb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x216b440>, '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': '03627c79f6bb3d1578c4a402000001ba-1502994294.323044-408794288', '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:37 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:37 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:37 INFO - Using env: {'DISPLAY': ':0', 11:25:37 INFO - 'HOME': '/home/cltbld', 11:25:37 INFO - 'LANG': 'en_US.UTF-8', 11:25:37 INFO - 'LANGUAGE': 'en_US:en', 11:25:37 INFO - 'LOGNAME': 'cltbld', 11:25:37 INFO - 'MAIL': '/var/mail/cltbld', 11:25:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:25:37 INFO - 'MOZ_NO_REMOTE': '1', 11:25:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:25:37 INFO - 'NO_EM_RESTART': '1', 11:25:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:25:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:25:37 INFO - 'PWD': '/builds/slave/test', 11:25:37 INFO - 'SHELL': '/bin/bash', 11:25:37 INFO - 'SHLVL': '1', 11:25:37 INFO - 'TERM': 'linux', 11:25:37 INFO - 'TMOUT': '86400', 11:25:37 INFO - 'USER': 'cltbld', 11:25:37 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1502994294.323044-408794288', 11:25:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:25:37 INFO - '_': '/tools/buildbot/bin/python'} 11:25:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:25:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:25:37 INFO - Running setup.py (path:/tmp/pip-9_6tu5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:25:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:25:38 INFO - Running setup.py (path:/tmp/pip-umz_9J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:25:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:25:38 INFO - Running setup.py (path:/tmp/pip-4od2aw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:25:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:25:38 INFO - Running setup.py (path:/tmp/pip-Romtjs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:25:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:25:38 INFO - Running setup.py (path:/tmp/pip-JR12IU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:25:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:25:38 INFO - Running setup.py (path:/tmp/pip-2HF57v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:25:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:25:38 INFO - Running setup.py (path:/tmp/pip-BxLMLD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:25:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:25:38 INFO - Running setup.py (path:/tmp/pip-8WPnFM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:25:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:25:38 INFO - Running setup.py (path:/tmp/pip-OakkNv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:25:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:25:38 INFO - Running setup.py (path:/tmp/pip-wRJKIe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:25:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:25:38 INFO - Running setup.py (path:/tmp/pip-QEjMXf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:25:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:25:38 INFO - Running setup.py (path:/tmp/pip-TOI8b5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:25:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:25:38 INFO - Running setup.py (path:/tmp/pip-zaf4xv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:25:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:25:38 INFO - Running setup.py (path:/tmp/pip-Wups3q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:25:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:25:38 INFO - Running setup.py (path:/tmp/pip-CcFRON-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:25:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:25:39 INFO - Running setup.py (path:/tmp/pip-o_TUZh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:25:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:25:39 INFO - Running setup.py (path:/tmp/pip-NNw_yr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:25:39 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:25:39 INFO - Running setup.py install for manifestparser 11:25:39 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:25:39 INFO - Running setup.py install for mozcrash 11:25:39 INFO - Running setup.py install for mozdebug 11:25:39 INFO - Running setup.py install for mozdevice 11:25:39 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:25:39 INFO - Running setup.py install for mozfile 11:25:39 INFO - Running setup.py install for mozhttpd 11:25:39 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:25:39 INFO - Running setup.py install for mozinfo 11:25:39 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:25:39 INFO - Running setup.py install for mozInstall 11:25:39 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:25:39 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:25:39 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:25:39 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:25:39 INFO - Running setup.py install for mozleak 11:25:40 INFO - Running setup.py install for mozlog 11:25:40 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:25:40 INFO - Running setup.py install for moznetwork 11:25:40 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:25:40 INFO - Running setup.py install for mozprocess 11:25:40 INFO - Running setup.py install for mozprofile 11:25:40 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:25:40 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:25:40 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:25:40 INFO - Running setup.py install for mozrunner 11:25:40 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:25:40 INFO - Running setup.py install for mozscreenshot 11:25:40 INFO - Running setup.py install for moztest 11:25:40 INFO - Running setup.py install for mozversion 11:25:40 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:25:40 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:25:40 INFO - Cleaning up... 11:25:40 INFO - Return code: 0 11:25:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:25:40 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:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:25:40 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:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:25:41 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 0x1ec51f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fc9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x216cef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x216a0b0>, '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 0x216afb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x216b440>, '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': '03627c79f6bb3d1578c4a402000001ba-1502994294.323044-408794288', '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:41 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:41 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:41 INFO - Using env: {'DISPLAY': ':0', 11:25:41 INFO - 'HOME': '/home/cltbld', 11:25:41 INFO - 'LANG': 'en_US.UTF-8', 11:25:41 INFO - 'LANGUAGE': 'en_US:en', 11:25:41 INFO - 'LOGNAME': 'cltbld', 11:25:41 INFO - 'MAIL': '/var/mail/cltbld', 11:25:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:25:41 INFO - 'MOZ_NO_REMOTE': '1', 11:25:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:25:41 INFO - 'NO_EM_RESTART': '1', 11:25:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:25:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:25:41 INFO - 'PWD': '/builds/slave/test', 11:25:41 INFO - 'SHELL': '/bin/bash', 11:25:41 INFO - 'SHLVL': '1', 11:25:41 INFO - 'TERM': 'linux', 11:25:41 INFO - 'TMOUT': '86400', 11:25:41 INFO - 'USER': 'cltbld', 11:25:41 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1502994294.323044-408794288', 11:25:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:25:41 INFO - '_': '/tools/buildbot/bin/python'} 11:25:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:25:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:25:41 INFO - Running setup.py (path:/tmp/pip-QCOaee-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:25:41 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:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:25:41 INFO - Running setup.py (path:/tmp/pip-BzdiD3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:25:41 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:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:25:41 INFO - Running setup.py (path:/tmp/pip-vdMTbp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:25:41 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:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:25:41 INFO - Running setup.py (path:/tmp/pip-Vlmf4m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:25:41 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:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:25:41 INFO - Running setup.py (path:/tmp/pip-amVjoY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:25:41 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:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:25:41 INFO - Running setup.py (path:/tmp/pip-hizG8e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:25:41 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:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:25:41 INFO - Running setup.py (path:/tmp/pip-jeZK8B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:25:41 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:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:25:41 INFO - Running setup.py (path:/tmp/pip-_uyL3w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:25:41 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:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:25:41 INFO - Running setup.py (path:/tmp/pip-kqkBEF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:25:41 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:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:25:41 INFO - Running setup.py (path:/tmp/pip-Xd2B0l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:25:41 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:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:25:41 INFO - Running setup.py (path:/tmp/pip-sw8LcX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:25:42 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:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:25:42 INFO - Running setup.py (path:/tmp/pip-cWxCyH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:25:42 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:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:25:42 INFO - Running setup.py (path:/tmp/pip-UYHQ5b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:25:42 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:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:25:42 INFO - Running setup.py (path:/tmp/pip-j6kK1t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:25:42 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:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:25:42 INFO - Running setup.py (path:/tmp/pip-nXsqQh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:25:42 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:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:25:42 INFO - Running setup.py (path:/tmp/pip-vSdaTO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:25:42 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:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:25:42 INFO - Running setup.py (path:/tmp/pip-rsyl78-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:25:42 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:42 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:42 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:42 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:42 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:42 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:42 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:42 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:25:42 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:42 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:42 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:42 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:43 INFO - Downloading blessings-1.6.tar.gz 11:25:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:25:43 INFO - Installing collected packages: blessings 11:25:43 INFO - Running setup.py install for blessings 11:25:43 INFO - Successfully installed blessings 11:25:43 INFO - Cleaning up... 11:25:43 INFO - Return code: 0 11:25:43 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:25:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:25:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:25:43 INFO - Reading from file tmpfile_stdout 11:25:43 INFO - Current package versions: 11:25:43 INFO - argparse == 1.2.1 11:25:43 INFO - blessings == 1.6 11:25:43 INFO - blobuploader == 1.2.4 11:25:43 INFO - docopt == 0.6.1 11:25:43 INFO - functools32 == 3.2.3-2 11:25:43 INFO - jsonschema == 2.5.1 11:25:43 INFO - manifestparser == 1.1 11:25:43 INFO - mozInstall == 1.13 11:25:43 INFO - mozcrash == 1.0 11:25:43 INFO - mozdebug == 0.1 11:25:43 INFO - mozdevice == 0.51 11:25:43 INFO - mozfile == 1.2 11:25:43 INFO - mozhttpd == 0.7 11:25:43 INFO - mozinfo == 0.10 11:25:43 INFO - mozleak == 0.1 11:25:43 INFO - mozlog == 3.5 11:25:43 INFO - moznetwork == 0.27 11:25:43 INFO - mozprocess == 0.25 11:25:43 INFO - mozprofile == 0.28 11:25:43 INFO - mozrunner == 6.13 11:25:43 INFO - mozscreenshot == 0.1 11:25:43 INFO - mozsystemmonitor == 0.3 11:25:43 INFO - moztest == 0.8 11:25:43 INFO - mozversion == 1.4 11:25:43 INFO - psutil == 3.1.1 11:25:43 INFO - requests == 1.2.3 11:25:43 INFO - wsgiref == 0.1.2 11:25:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:25:43 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:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:25:43 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:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:25:44 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 0x1ec51f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fc9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x216cef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x216a0b0>, '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 0x216afb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x216b440>, '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': '03627c79f6bb3d1578c4a402000001ba-1502994294.323044-408794288', '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:44 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:44 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:44 INFO - Using env: {'DISPLAY': ':0', 11:25:44 INFO - 'HOME': '/home/cltbld', 11:25:44 INFO - 'LANG': 'en_US.UTF-8', 11:25:44 INFO - 'LANGUAGE': 'en_US:en', 11:25:44 INFO - 'LOGNAME': 'cltbld', 11:25:44 INFO - 'MAIL': '/var/mail/cltbld', 11:25:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:25:44 INFO - 'MOZ_NO_REMOTE': '1', 11:25:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:25:44 INFO - 'NO_EM_RESTART': '1', 11:25:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:25:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:25:44 INFO - 'PWD': '/builds/slave/test', 11:25:44 INFO - 'SHELL': '/bin/bash', 11:25:44 INFO - 'SHLVL': '1', 11:25:44 INFO - 'TERM': 'linux', 11:25:44 INFO - 'TMOUT': '86400', 11:25:44 INFO - 'USER': 'cltbld', 11:25:44 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1502994294.323044-408794288', 11:25:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:25:44 INFO - '_': '/tools/buildbot/bin/python'} 11:25:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:25:44 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:44 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:44 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:44 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:44 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:44 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:44 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:44 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:44 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:44 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 11:25:44 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:44 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:44 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:44 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:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 11:25:45 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:45 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:45 INFO - Installing collected packages: simplejson 11:25:45 INFO - Running setup.py install for simplejson 11:25:45 INFO - building 'simplejson._speedups' extension 11:25:45 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:46 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:46 INFO - Successfully installed simplejson 11:25:46 INFO - Cleaning up... 11:25:46 INFO - Return code: 0 11:25:46 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:25:46 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:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:25:46 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:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:25:46 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 0x1ec51f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fc9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x216cef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x216a0b0>, '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 0x216afb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x216b440>, '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': '03627c79f6bb3d1578c4a402000001ba-1502994294.323044-408794288', '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:46 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:46 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:46 INFO - Using env: {'DISPLAY': ':0', 11:25:46 INFO - 'HOME': '/home/cltbld', 11:25:46 INFO - 'LANG': 'en_US.UTF-8', 11:25:46 INFO - 'LANGUAGE': 'en_US:en', 11:25:46 INFO - 'LOGNAME': 'cltbld', 11:25:46 INFO - 'MAIL': '/var/mail/cltbld', 11:25:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:25:46 INFO - 'MOZ_NO_REMOTE': '1', 11:25:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:25:46 INFO - 'NO_EM_RESTART': '1', 11:25:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:25:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:25:46 INFO - 'PWD': '/builds/slave/test', 11:25:46 INFO - 'SHELL': '/bin/bash', 11:25:46 INFO - 'SHLVL': '1', 11:25:46 INFO - 'TERM': 'linux', 11:25:46 INFO - 'TMOUT': '86400', 11:25:46 INFO - 'USER': 'cltbld', 11:25:46 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1502994294.323044-408794288', 11:25:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:25:46 INFO - '_': '/tools/buildbot/bin/python'} 11:25:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:25:46 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:25:46 INFO - Cleaning up... 11:25:46 INFO - Return code: 0 11:25:46 INFO - Running post-action listener: _resource_record_post_action 11:25:46 INFO - Running post-action listener: _start_resource_monitoring 11:25:46 INFO - Starting resource monitoring. 11:25:46 INFO - [mozharness: 2017-08-17 18:25:46.685570Z] Finished create-virtualenv step (success) 11:25:46 INFO - [mozharness: 2017-08-17 18:25:46.686087Z] Running install step. 11:25:46 INFO - Running pre-action listener: _resource_record_pre_action 11:25:46 INFO - Running main action method: install 11:25:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:25:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:25:46 INFO - Reading from file tmpfile_stdout 11:25:46 INFO - Detecting whether we're running mozinstall >=1.0... 11:25:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:25:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:25:47 INFO - Reading from file tmpfile_stdout 11:25:47 INFO - Output received: 11:25:47 INFO - Usage: mozinstall [options] installer 11:25:47 INFO - Options: 11:25:47 INFO - -h, --help show this help message and exit 11:25:47 INFO - -d DEST, --destination=DEST 11:25:47 INFO - Directory to install application into. [default: 11:25:47 INFO - "/builds/slave/test"] 11:25:47 INFO - --app=APP Application being installed. [default: firefox] 11:25:47 INFO - mkdir: /builds/slave/test/build/application 11:25:47 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:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 11:26:04 INFO - Reading from file tmpfile_stdout 11:26:04 INFO - Output received: 11:26:04 INFO - /builds/slave/test/build/application/firefox/firefox 11:26:04 INFO - Running post-action listener: _resource_record_post_action 11:26:04 INFO - [mozharness: 2017-08-17 18:26:04.873027Z] Finished install step (success) 11:26:04 INFO - [mozharness: 2017-08-17 18:26:04.873284Z] Running setup-mitmproxy step. 11:26:04 INFO - Running pre-action listener: _resource_record_pre_action 11:26:04 INFO - Running main action method: setup_mitmproxy 11:26:04 INFO - Skipping: mitmproxy is not required 11:26:04 INFO - Running post-action listener: _resource_record_post_action 11:26:04 INFO - [mozharness: 2017-08-17 18:26:04.874444Z] Finished setup-mitmproxy step (success) 11:26:04 INFO - [mozharness: 2017-08-17 18:26:04.874667Z] Running run-tests step. 11:26:04 INFO - Running pre-action listener: _resource_record_pre_action 11:26:04 INFO - Running pre-action listener: _set_gcov_prefix 11:26:04 INFO - Running main action method: run_tests 11:26:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:26:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:26:04 INFO - Python 2.7.3 11:26:04 INFO - Return code: 0 11:26:04 INFO - grabbing minidump binary from tooltool 11:26:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:26:04 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--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 0x216a0b0>, '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 0x216afb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x216b440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:26:04 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--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:26:04 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 11:26:04 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--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:26:04 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:26:05 INFO - Return code: 0 11:26:05 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:26:05 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:26:05 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:26:05 INFO - ENV: RUST_BACKTRACE is now full 11:26:05 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:26:05 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:26:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ej7oj6HVS_W6qwoEs3vqHQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-047', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 11:26:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ej7oj6HVS_W6qwoEs3vqHQ/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-047 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 11:26:05 INFO - Using env: {'DISPLAY': ':0', 11:26:05 INFO - 'HOME': '/home/cltbld', 11:26:05 INFO - 'LANG': 'en_US.UTF-8', 11:26:05 INFO - 'LANGUAGE': 'en_US:en', 11:26:05 INFO - 'LOGNAME': 'cltbld', 11:26:05 INFO - 'MAIL': '/var/mail/cltbld', 11:26:05 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:26:05 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:26:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:26:05 INFO - 'MOZ_NO_REMOTE': '1', 11:26:05 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:26:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:26:05 INFO - 'NO_EM_RESTART': '1', 11:26:05 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:26:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:26:05 INFO - 'PWD': '/builds/slave/test', 11:26:05 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:26:05 INFO - 'RUST_BACKTRACE': 'full', 11:26:05 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 11:26:05 INFO - 'SHELL': '/bin/bash', 11:26:05 INFO - 'SHLVL': '1', 11:26:05 INFO - 'TERM': 'linux', 11:26:05 INFO - 'TMOUT': '86400', 11:26:05 INFO - 'USER': 'cltbld', 11:26:05 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1502994294.323044-408794288', 11:26:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:26:05 INFO - '_': '/tools/buildbot/bin/python'} 11:26:05 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ej7oj6HVS_W6qwoEs3vqHQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-047', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 11:26:05 INFO - mozversion application_buildid: 20170817171339 11:26:05 INFO - mozversion application_changeset: f53a37fc0e92c093bf48baada9f9adab16422cd7 11:26:05 INFO - mozversion application_display_name: Nightly 11:26:05 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:26:05 INFO - mozversion application_name: Firefox 11:26:05 INFO - mozversion application_remotingname: firefox 11:26:05 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 11:26:05 INFO - mozversion application_vendor: Mozilla 11:26:05 INFO - mozversion application_version: 57.0a1 11:26:05 INFO - mozversion platform_buildid: 20170817171339 11:26:05 INFO - mozversion platform_changeset: f53a37fc0e92c093bf48baada9f9adab16422cd7 11:26:05 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 11:26:05 INFO - mozversion platform_version: 57.0a1 11:26:05 INFO - using testdate: 1502994365 11:26:05 INFO - actual date: 1502994365 11:26:05 INFO - starting webserver on 'localhost:36250' 11:26:05 INFO - SUITE-START | Running 2 tests 11:26:05 INFO - TEST-START | dromaeo_css 11:26:05 INFO - Initialising browser for dromaeo_css test... 11:26:05 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:36250/getInfo.html -profile /tmp/tmp9Fw0P_/profile 11:26:05 INFO - TEST-INFO | started process 12909 (/builds/slave/test/build/application/firefox/firefox http://localhost:36250/getInfo.html) 11:26:10 INFO - TEST-INFO | 12909: exit 0 11:26:10 INFO - Browser initialized. 11:26:10 INFO - Running cycle 1/1 for dromaeo_css test... 11:26:10 INFO - TEST-INFO | started process 13085 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp9Fw0P_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 11:26:11 INFO - PID 13085 | 11:26:11 INFO - PID 13085 | (/builds/slave/test/build/application/firefox/firefox:13135): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 11:26:11 INFO - PID 13085 | 11:26:22 INFO - PID 13085 | RSS: Main: 156758016 11:26:22 INFO - PID 13085 | 11:29:19 INFO - PID 13085 | Cycle 1(1): loaded http://localhost:36250/tests/dromaeo/cssquery-dojo.html (next: http://localhost:36250/tests/dromaeo/cssquery-ext.html) 11:29:20 INFO - PID 13085 | RSS: Main: 165801984 11:29:20 INFO - PID 13085 | 11:32:22 INFO - PID 13085 | Cycle 1(1): loaded http://localhost:36250/tests/dromaeo/cssquery-ext.html (next: http://localhost:36250/tests/dromaeo/cssquery-jquery.html) 11:32:22 INFO - PID 13085 | RSS: Main: 162594816 11:32:22 INFO - PID 13085 | 11:35:24 INFO - PID 13085 | Cycle 1(1): loaded http://localhost:36250/tests/dromaeo/cssquery-jquery.html (next: http://localhost:36250/tests/dromaeo/cssquery-mootools.html) 11:35:24 INFO - PID 13085 | RSS: Main: 165281792 11:35:24 INFO - PID 13085 | 11:38:26 INFO - PID 13085 | Cycle 1(1): loaded http://localhost:36250/tests/dromaeo/cssquery-mootools.html (next: http://localhost:36250/tests/dromaeo/cssquery-prototype.html) 11:38:27 INFO - PID 13085 | RSS: Main: 163307520 11:38:27 INFO - PID 13085 | 11:41:30 INFO - PID 13085 | Cycle 1(1): loaded http://localhost:36250/tests/dromaeo/cssquery-prototype.html (next: http://localhost:36250/tests/dromaeo/cssquery-yui.html) 11:41:30 INFO - PID 13085 | RSS: Main: 167096320 11:41:30 INFO - PID 13085 | 11:44:32 INFO - PID 13085 | Cycle 1(1): loaded http://localhost:36250/tests/dromaeo/cssquery-yui.html (next: http://localhost:36250/tests/dromaeo/cssquery-dojo.html) 11:44:32 INFO - PID 13085 | RSS: Main: 167747584 11:44:32 INFO - PID 13085 | 11:44:32 INFO - PID 13085 | __start_tp_report 11:44:32 INFO - PID 13085 | _x_x_mozilla_page_load 11:44:32 INFO - PID 13085 | _x_x_mozilla_page_load_details 11:44:32 INFO - PID 13085 | |i|pagename|runs| 11:44:32 INFO - PID 13085 | |0;dojo.html;3477.982610086949;3502.1944952660897;3510.2979404119164;3516.3846326892785;3541.2386336937557;6189.7524099036045;6319.684015799209;6336.176297081373;6339.30267670557;6387.393197646222;6169.043798211284;6259.280182778982;6265.091561723559;6283.622982621046;6369.4585960193435;5507.394186639486;5513.476219759116;5551.333839939192;5586.888262234763;5588.832335029955;318.4436068714158;5470.261514695525;5476.698781567012;5626.521745651604;5628.43715628438;5461.481159289861;5502.972485137549;5581.748821303051;5584.246126772874;5585.05054140795;5499.175123731432;5502.257195278627;5562.721863906829;5574.637648552831;5576.302962129734;5448.4279150689;5458.4814442627885;5512.641678290938;5527.336719593634;5533.557315414757;6202.224721909762;6207.037909124093;6241.313455519889;6269.341719119518;6296.496280297565;6630.403263706289;6751.25736169021;6770.289119642465;6781.593104413751;6867.690953907087;6781.355771201728;6874.106366172366;6894.24163342032;6948.5483443576;6973.12835895513;6317.968410157966;6331.366863313678;6331.683415829236;6333.429991300805;6338.841528961767;7043.9647801761685;7044.823879402953;7094.432445404355;7117.252688467636;7124.50128491011;6604.636744978976;6708.932910670928;6743.494237932175;6784.966075169691;6800.965995169992;6801.625910574966;6817.318268173143;6820.761273355409;6829.556078854858;6829.897551536731;6836.6923488443135;6837.213720422115;6840.794776156723;6851.931480685229;6872.896906546406;6643.7674681385915;6878.759243426456;6886.965565172142;6889.793306200822;6891.517593768388;4911.336969509142;4919.950800491949;4922.778474968635;4956.306117143603;4970.975145124324;4411.029573493826;4417.315316126005;4417.734935903792;4440.111977604492;4452.065066336041;6439.871202575922;6448.1295025171;6448.613083215022;6516.674166291667;6562.8359291018105;6737;6807.149106361705;6847.931520684829;6867.828304292333;6892.827679307957;6523.869522609616;6525.641089740015;6541.967290163519;6546.149000629983;6553.279139294674;5479.479449452296;5509.972450137724;5530.5022547970075;5533.667979921218;5538.390777014525;7129;7147.499675022803;7219.566825990458;7262.092238470192;7265.600391978386;6851.45188384928;6855.725770969106;6923.065386173003;6931.618760968095;6935.133108361455;7026.718931242693;7037.049998250171;7176.605286709072;7178.461615378972;7279.963600181965;6706.798796036127;6715.899261510984;6729.528932974645;6731.831704207434;6817.829554261183;6864.897026544706;6865.656717164022;6888.724451021903;6936.167659880846;6955.061066755923;6569.704363303758;6651.301613330531;6708.060871477899;6709.228438729609;6729.528932974645;6608.693917847631;6626.469882409299;6627.37039981201;6713.832154196184;6735.4274886635185;6562.081308616893;6663.766768163285;6668.066470694203;6710.899336509859;6737.663116844236;6716.630585317855;6734.797956061326;6743.393094621508;6782.626955517494;6805.829854253683;6529.347065293433;6572.507061970276;6583.934160658524;6603.141591593062;6626.734930602915 11:44:32 INFO - PID 13085 | |1;ext.html;864.1584993149961;897.5512243878065;926.9443833369997;949.4303417949227;953.0612346838363;42496.78751606242;43737;43747.12505749883;43828.12343753123;44023;41270.79364603173;41545.16909661813;41667;41685;41717.582824171746;6803.829904252396;6913.965430172842;6914.343137401939;6915.308469153095;6919.65401729914;6837.829054273658;6914.412274956635;6915.997180408837;6916.2737912519215;6991;6970.4075153612;6996.650167491631;6996.7201311947465;6998.405135563457;6998.510104292702;6930.653467326639;6960.79117626472;6964.825879353006;6966.860662786716;6971.128608923885;6339.524535659844;6393.616383016987;6394.680265986682;6397.648129352884;6399.9360006400275;35650.10874728153;35659;35916;35919.102022449646;35971.64028359709;3357.3956687796185;3389.983050084734;3392.406328892434;3393.321335732863;3401.6088149862835;27986.580201296998;28033.859830700716;28074.2981425466;28108;28175.718242817515;4431.468223813131;4452.933206001912;4465.776711164462;4479.753613551254;4486.955130448687;200700.99999999854;201156;201328;201997;202588;22536.436589085402;22727.204547841076;22734.431639208822;22766.65850012251;22812.885935570215;23308.067677292718;23317.650235246485;23344.533109337717;23371;23397.7660223399;13472.932635336761;13705.383257753425;13706.24615646149;13713.794293085612;13717.794233086512;13322.333883305795;13347.265900375573;13422.530211442749;13429.261390623415;13452.192868427926;5999.460048595647;6024.518038556905;6037.275526936708;6084.513238940963;6090.23872015998;2576.3687896465112;2615.751503607154;2633.249523885683;2636.6045093235784;2657.7342265773655;1094.6059418609295;1102.8290614954694;1104.817705078653;1110.21729680575;1110.8444817725524;25243.116490923097;25270.873645631655;25311.873440633048;25333.873330633596;25334.239972800846;1190.0549677818005;1198.394810620631;1209.4920133543933;1219.969500762488;1224.6632176151452;13387.397567109503;13418.597442076752;13517.256550889599;13551.25468099264;13615.52345667897;235291;249224;252952;253258;253508;49952;50998.235026474635;55206.44793552093;56846.147307790416;56846.43153568411;1516.4768154986511;1528.6484108655072;1548.8606025457539;1550.9612259693372;1551.0848599326453;29347.7065229345;29458.263543411587;29517.26206844846;29808.552871707376;30098.398032039673;53898;54401.727991361375;54456.183157253465;54499.182512261556;54520.182197267866;231392;232507;232565;232840;233114;35479.645203548665;35681;35741.642583573834;35815.46276805902;35955.640443596276;45077.32384014177;45156.548434516546;45177.774111129234;45303.320450192616;45527.089458209986;33923.83038084794;33998.32003359968;34188.48717269293;34425;34714;33658;33887.322253555285;34118.48822267717;34164.316713666085;34545.654543455246;39374.21251574895;39441.21117577575;40011.399829002;40105.39841902316;40284.3957340646;33040.66959330376;33130.5030424539;33375.666243337255;33536;33795.493067603515;24621.38446538851;24713.135040273504;25275.620865686662;25632.743672563036;25860.741392586588 11:44:32 INFO - PID 13085 | |2;jquery.html;548.7996881138383;553.3138907754385;569.6183557016799;572.253209561522;582.7173820696962;22565.097396104156;23163.768362316372;23212.8839355803;23261.418464538394;23469;26746.331341716468;27241;27269;27287.863560682217;27316.726832731667;6208.50331973441;6380.808575742735;6382.904256436157;6387.329330420309;6396.2964073951825;6101.35935726749;6135.938640613582;6335.493160547145;6358.84102897429;6366.586171898835;6294.181756371665;6322.620642761426;6324.652144132071;6327.3988971047675;6335.208098987627;6333.55665103443;6334.176557047577;6344.397282258178;6346.30190679025;6352.237731472207;5863;5872.207252020965;5876.08920617305;5879.647221166701;5892.086726557391;30180.24549386283;30964.225894352596;31061.37877242465;31176.53235201474;31406.685933140605;2228.2646726580188;2258.5144193998367;2259.4690247791755;2259.5480903819303;2267.682524446579;20195.19219231229;20759;20763.480912977146;20768.792312076836;20783.37649870491;2450.718167410753;2501.374656335916;2539.4032402385424;2542.6058960861096;2547.3886267295716;151958.9999999989;156191;160496;160555;160870;15294.311755971008;15567.29947152381;15828.60428489297;15913.443029493912;15924.840751592335;23362.299131026095;23560.528789424457;23594.882025589763;23612.40968975755;24035.519289614458;10655.786884262272;10670.25308228432;10703.46482675863;10757.354558726502;10971.945140274407;9951.353162044445;9973.50132493387;10000.599976001024;10079.798404031879;10226.23303252259;9649.372790768577;9728.719363480046;9757.560909759079;9890.752731181778;10141.290109692398;2639.1818536253822;2672.225054734144;2747;2799.496090703652;2897.7392034716977;1050.2805578178973;1064.0157853985188;1074.462768615692;1083.4420273559124;1105.1214284643727;21668.45828854291;21833;22009.559808803733;22021.22925697625;22072.779272207394;1146.4439746722833;1147.3058799426226;1149.2759561476216;1154.203599516331;1155.8555180602425;11671.183017188885;12308;12320.507179712711;12351.444185011696;12372.876271237352;531629;534826;594612;605172;607665;132597;140383;140407.29796350954;141347;142533.28733356268;1318.1695531814896;1324.8608896065966;1369.9109557878905;1370.9383077761524;1378.5519706095558;22468.66297005579;22554.436139096655;22581.548369032855;22933.54132917299;23308.184213552446;62146.37853621406;62524.687376562826;62952;64423.67788161029;66125.66937165284;74455.25544744483;74637;75124;75592.24407756072;75652.62173689096;14805.703885922436;15318.463853765064;15390.153541555323;15425.382984680487;15473.226338683246;24237.515249694556;24323;24608;24703;24957.500849983262;19878.403647890587;19902.70145947841;19950.401487955383;20121.195152194334;20245.898770506054;17417.82582174162;17560.648787023933;17989.550261243574;18165.36421225251;18549.721754173428;19948.30180943718;20393.79606203919;20494.28270010602;20572.279970200972;20597.79402205959;14877.702445951238;14896.851031489547;14981.40074397012;15009.399624014917;15150.924245378703;19648.508787280432;19761.703574446106;20016.49958751043;20054.59890802205;20117.49706257355 11:44:32 INFO - PID 13085 | |3;mootools.html;1445.421831267493;1511.6901035287763;1514.9394024239025;1530.380196020612;1531.4486784757491;15824.604384890383;16430.671386572278;16455.835441645595;16457.506274811745;16462.917685411587;15783.526494205164;16245.431409900655;16939.3224271029;16955.57611059724;16958.576035599086;2601.752833480821;2660.5876089206204;2661.7072122066556;2663.73362663734;2664.760171584557;2596.8831402586834;2648.774854137401;2671.9465610687776;2708.8374697518116;2714.6335244741904;2697.4200546882416;2723.8638068096616;2732.248631626299;2732.4808286425614;2732.9863350683218;2632.986835065822;2649.1390298153083;2651.655284812962;2658.617518890176;2662.1614191529607;2551.1836212412036;2551.413174969749;2560.9871950640313;2564.2563656539583;2565.3586603349163;15682.607934801606;15974.76037859433;15976.680466390608;15982.360705571764;15997.840021599752;7996.24035716606;8265.95867020667;8269.545175015372;8271.255586997138;8275.917240827575;5256.81601143962;5266.447023062561;5380.623356365056;5418.726599249173;5434.184872269152;1921.5388306806406;1934.84521238302;1936.4674714453497;1977.574821413403;1978.4658142301641;28707.56938645922;28886.277843053882;29088;29136.70863291361;29393.265168370963;6451.548391612636;6950.061741664912;7025.648717564101;7112.751053713096;7200.567965922061;18669.253229870654;18901.43295701131;18943.90528047351;19863.60272794536;19889.502762431053;7901;8027.879581806277;8111.1888811118415;8122.593870306461;8123.065847427503;7355.301246381585;7420.628968551551;7447.292507211914;7471.290227428385;7566.470347075762;5184.8963020739375;5427.538659213932;5428.104362780176;5430.456954304538;5446.591505637093;1555.6655319106446;1565.8434156584478;1567.5924259692333;1582.3670531787377;1599.336689842574;954.2223088183108;973.956171972263;983.9704808855746;1000.0049950299499;1005.7636455432968;8413.158684131538;8458.788530286669;8511.191436813493;8541.658333666708;8640.611172497127;714.739120221126;754.724525548182;1035.5961175141701;1041.1150522056191;1047.607147319755;6189.907151392733;6552.279249282575;6688.632125233159;6927.445804335641;6944.097267355211;23197.42006449852;23235.419114521934;24153.879230603736;24208.757912421002;24212.515749684906;22844.971976260775;23439.88280058623;23516.882415588156;23636.40908977255;23639.527209455715;12427.192232504858;12759.42582583786;12779.23324600527;12981.286029268482;13032.54386096482;9546.61813527479;9569.138777510057;9572.473513956798;9608.519574021131;9860.211183105477;20446.897765511076;20508.589828203054;20575.588488230453;20805.375838724864;21463.356099317047;20939.790602093784;20970.580588388453;21103.155873764877;21218.57562848765;21707.565848683254;13095.672608184872;13446.798298025342;13454.26001569923;13457.394417251051;13461.461541538229;14618.707625847212;14980.775288370902;15132.167730774472;15137;15184.924075379553;11658.358790266617;11831.881681183078;11917.82123268169;12056.216345937486;12112.697182570506;11589.420528973349;11722.765544688888;11778.823317650413;11898.464569094238;11969.64091077269;10560.947195263974;10705.304155230197;10715.892841071489;10729.731756706145;10738.516766745672;8327.333813295043;8359.540225287668;8380.916190838014;8451.112633173429;8479.703210387606;8228;8235.547044912588;8235.723462863265;8251.587420629065;8315.293200078062 11:44:32 INFO - PID 13085 | |4;prototype.html;506.7213032831944;515.1860061103457;529.2722506553488;541.2611784913589;544.8855740294538;6034.8793024139495;6139.662318572482;6149.508039356852;6155.784547540837;6172.845678858031;6015.6992150392525;6019.645579744555;6033.7888173913925;6056.152138700585;6063.181470501481;4736.69211501253;4739.241721324589;4768.308595253686;4768.380110585619;4774.665773395864;4650.604698600606;4720.952790472103;4757;4780.856574302777;4782;4725.362076119732;4731.148393289207;4750.643701722384;4752.76236188191;4817.78319975602;4704.247320428749;4720.858374248761;4750.762461876927;4763.595094416979;4774.49867763885;4250.682288490547;4271.209826182135;4321.9135617287475;4333.9197185350895;4343;5867.413258674141;5917.112433135021;5927.3776253493625;6018.6689732064715;6019.939800601982;5565.9443405566235;5590.888182236373;5667;5674.120511320752;5699.943000569982;6364;6399.200099987502;6438.360272288386;6457.741690332381;6488.480921526267;4817.277408388734;4821.951780482185;4849;4869.366982292315;4895.657303988723;6624.436922861562;6729.427998620172;6736.831579210559;6817.659117044128;6890.44876409886;4966.180580204225;4986.850394488171;5008.949910500921;5021.4225364083595;5061.772220250097;5078.289039534468;5098.260752190911;5098.5411312982005;5102.413222479388;5104.770285337168;5578.41426650204;5621.578381621313;5629.296337957755;5670.177824215548;5677.971610141923;6288.308286088527;6375.521835862329;6377.681115944184;6436.710348034349;6461.773837915651;1709.2735587375316;1737.2008875916968;1745.8079611242754;1755.4558086993072;1756.3062590277025;1084.6366467233408;1207.9249467973511;1220.4690959432676;1234.950601975929;1259.7921342978307;6033.5173186145;6100.664463454464;6182.969085154546;6207.782727604512;6245.188125543741;6507.251666058369;6559.770408035696;6632.83417914556;6654.500912431587;6689.130413046273;6218.22272215973;6229.470495007885;6255.280642726054;6279.748810047547;6328.71520781566;3469.2020835208045;3473.8784142555396;3474.6004209515722;3512.4204506256183;3529.9823500882844;6881.277465866112;6881.380675739108;6916.757913473004;7004.124484439445;7037;6708.3291670833505;6716.194056713128;6777.390034896883;6785.558938668971;6843.973403989342;6914;6960.512764106566;6984.546004509691;6990.335918087773;7030.824229394101;6527.5430719849155;6591.604503729792;6621.205455345389;6662.666866656745;6690.19717633887;6486.383793539795;6539.7384104637185;6584.637844918384;6644.83387915306;6674.766383176566;6919.861602767815;6939.930600693929;6988.720451181895;6999.055127557918;7062.258462861531;5035.974820125876;5042.1932490802765;5058.721770302669;5082.796688132581;5088.669236499616;6600.240972288057;6656.73373065072;6694.430973367123;6757.560758550679;6792.830179245559;6411.871762564816;6412.775552855627;6460.612363258219;6482.675866206577;6526.347365263436;6438.227412710505;6446.035688051908;6513.316101809241;6525.64108974011;6573.290944354598;6439.935600644121;6442.6470441207875;6478.6436745977535;6496.512761542997;6509.511786615928;5945.910811337747;6535.57518761279;6547.574407663486;6573.704183311666;6605.306442823435;6289.000244805482;6327.778527751507;6348.191085348753;6351.30135685065;6359.554831161774 11:44:32 INFO - PID 13085 | |5;yui.html;934.308611627396;943.3538475360496;951.8096380723857;958.9184919281861;976.990230097699;18867.528311792194;19781.703274450894;19791.406257812254;19848.305309314175;22612.88693556534;21915.561688766215;21977.67033494499;22048;22066.33800985969;22073.558528829413;1076.4617691154422;1102.40470146121;1106.7122548137502;1109.0628418985943;1110.7389763405592;1014.3305418423842;1031.705963800317;1076.1874784537663;1084.0027174998982;1093.4314156638543;1142.959996400126;1154.2209008918946;1154.7517283783984;1155.5146838327923;1155.7284038251046;1142.4173671427548;1149.4367759797722;1150.2178518607343;1151.2746969409302;1155.7284038251005;835.2941764209233;842.9968337678205;843.0431460292551;843.5992903370911;845.0408786027903;18889.338873139375;18905;18948.715769263334;20403.795962040338;21577.352679419644;22615.208467703553;22780.658290125662;23281.301560953198;23324.883375583184;23658.526829463488;17570;17836.643267134714;17844.643107137785;18144.18351174187;18274;3628;3645.927081458356;3648.872289469856;3650.908727281839;3651.525301710787;136593.3170334152;137518.3124084373;137965.3101734485;138767;139725;18003;18524.351647692267;18555.72166417505;18616.720749188775;18679.439616811516;33986.83006584951;34155.14612134716;34804.477932831025;35060.29879402398;35088.298234035174;9148.405353651991;9255.629774808933;9270.30472714549;9284.118008789153;9291.442513449214;4666.766661666903;4743.383360163157;4744.074905393415;4749.121412538691;4749.643776716691;5453.945460545423;5563.499285064364;5632.436756324335;5634.070378387602;5634.1830434586755;1140.2645293785463;1160.5067846165346;1172.3903570143477;1175.124532223499;1175.7589694112687;679.212113947828;690.4372936057098;699.4788882282731;709.6274455910689;750.3284560318484;12749.808752868714;14825.332860021324;15117.697646047238;15192;16409.261583228785;729.5221629832469;733.1861633586715;750.3584435307843;751.6805357722945;763.1872056260065;6346.11154438379;6587.4071333580205;6638.20341559016;6677.198736151596;6696.966515167393;128223.35888320499;129176.19510250703;138271;139483;142702;109148;111634;116623.41688291675;117855;123792;105629.47185264024;105688.94311056945;106277;107516.99999999843;109655.45172274247;13685.131049646692;14347.856521434653;14414.85585144135;14611.561653150422;14744.336504857522;48618;49381.25928111153;50157.74921125371;50296.99406011932;50873.49126508687;81358.59320703358;84404.57797710971;84697.57651211704;84834.15165848509;86267;20358;20895.582088358453;21053.684194737398;21097.683534746684;21234.57530849405;24180.39549011289;24212.63681044821;24374.634380483953;24442.87778561167;24455.266342009767;20982.160713571287;21050.368488945354;21103.57792844104;21204.575908481434;21833.126674932824;20496.79503204949;20646.58706825885;20972.056257468757;21001.369958901258;21011.68482472795;19812.405627831187;20626.071826767533;20993.160273589496;21413.419115816385;21592;14710.926445367704;14909;15241.466548670744;15264.771028434805;15596.68806623884;12218.083643726579;13043.086983911415;15345.156016418758;16174;16538.66922661516 11:44:32 INFO - PID 13085 | __end_tp_report 11:44:32 INFO - PID 13085 | __start_cc_report 11:44:32 INFO - PID 13085 | _x_x_mozilla_cycle_collect,346 11:44:32 INFO - PID 13085 | __end_cc_report 11:44:32 INFO - PID 13085 | __startTimestamp1502995472720__endTimestamp 11:44:32 INFO - PID 13085 | 11:44:32 INFO - PID 13085 | ------- Summary: start ------- 11:44:32 INFO - PID 13085 | Number of tests: 6 11:44:32 INFO - PID 13085 | 11:44:32 INFO - PID 13085 | [#0] dojo.html Cycles:165 Average:6249.76 Median:6608.69 stddev:947.71 (14.3%) stddev-sans-first:925.33 11:44:32 INFO - PID 13085 | Values: 3478.0 3502.2 3510.3 3516.4 3541.2 6189.8 6319.7 6336.2 6339.3 6387.4 6169.0 6259.3 6265.1 6283.6 6369.5 5507.4 5513.5 5551.3 5586.9 5588.8 318.4 5470.3 5476.7 5626.5 5628.4 5461.5 5503.0 5581.7 5584.2 5585.1 5499.2 5502.3 5562.7 5574.6 5576.3 5448.4 5458.5 5512.6 5527.3 5533.6 6202.2 6207.0 6241.3 6269.3 6296.5 6630.4 6751.3 6770.3 6781.6 6867.7 6781.4 6874.1 6894.2 6948.5 6973.1 6318.0 6331.4 6331.7 6333.4 6338.8 7044.0 7044.8 7094.4 7117.3 7124.5 6604.6 6708.9 6743.5 6785.0 6801.0 6801.6 6817.3 6820.8 6829.6 6829.9 6836.7 6837.2 6840.8 6851.9 6872.9 6643.8 6878.8 6887.0 6889.8 6891.5 4911.3 4920.0 4922.8 4956.3 4971.0 4411.0 4417.3 4417.7 4440.1 4452.1 6439.9 6448.1 6448.6 6516.7 6562.8 6737.0 6807.1 6847.9 6867.8 6892.8 6523.9 6525.6 6542.0 6546.1 6553.3 5479.5 5510.0 5530.5 5533.7 5538.4 7129.0 7147.5 7219.6 7262.1 7265.6 6851.5 6855.7 6923.1 6931.6 6935.1 7026.7 7037.0 7176.6 7178.5 7280.0 6706.8 6715.9 6729.5 6731.8 6817.8 6864.9 6865.7 6888.7 6936.2 6955.1 6569.7 6651.3 6708.1 6709.2 6729.5 6608.7 6626.5 6627.4 6713.8 6735.4 6562.1 6663.8 6668.1 6710.9 6737.7 6716.6 6734.8 6743.4 6782.6 6805.8 6529.3 6572.5 6583.9 6603.1 6626.7 11:44:32 INFO - PID 13085 | 11:44:32 INFO - PID 13085 | [#1] ext.html Cycles:180 Average:38472.22 Median:18658.58 stddev:59648.93 (319.7%) stddev-sans-first:59749.42 11:44:32 INFO - PID 13085 | Values: 864.2 897.6 926.9 949.4 953.1 42496.8 43737.0 43747.1 43828.1 44023.0 41270.8 41545.2 41667.0 41685.0 41717.6 6803.8 6914.0 6914.3 6915.3 6919.7 6837.8 6914.4 6916.0 6916.3 6991.0 6970.4 6996.7 6996.7 6998.4 6998.5 6930.7 6960.8 6964.8 6966.9 6971.1 6339.5 6393.6 6394.7 6397.6 6399.9 35650.1 35659.0 35916.0 35919.1 35971.6 3357.4 3390.0 3392.4 3393.3 3401.6 27986.6 28033.9 28074.3 28108.0 28175.7 4431.5 4452.9 4465.8 4479.8 4487.0 200701.0 201156.0 201328.0 201997.0 202588.0 22536.4 22727.2 22734.4 22766.7 22812.9 23308.1 23317.7 23344.5 23371.0 23397.8 13472.9 13705.4 13706.2 13713.8 13717.8 13322.3 13347.3 13422.5 13429.3 13452.2 5999.5 6024.5 6037.3 6084.5 6090.2 2576.4 2615.8 2633.2 2636.6 2657.7 1094.6 1102.8 1104.8 1110.2 1110.8 25243.1 25270.9 25311.9 25333.9 25334.2 1190.1 1198.4 1209.5 1220.0 1224.7 13387.4 13418.6 13517.3 13551.3 13615.5 235291.0 249224.0 252952.0 253258.0 253508.0 49952.0 50998.2 55206.4 56846.1 56846.4 1516.5 1528.6 1548.9 1551.0 1551.1 29347.7 29458.3 29517.3 29808.6 30098.4 53898.0 54401.7 54456.2 54499.2 54520.2 231392.0 232507.0 232565.0 232840.0 233114.0 35479.6 35681.0 35741.6 35815.5 35955.6 45077.3 45156.5 45177.8 45303.3 45527.1 33923.8 33998.3 34188.5 34425.0 34714.0 33658.0 33887.3 34118.5 34164.3 34545.7 39374.2 39441.2 40011.4 40105.4 40284.4 33040.7 33130.5 33375.7 33536.0 33795.5 24621.4 24713.1 25275.6 25632.7 25860.7 11:44:32 INFO - PID 13085 | 11:44:32 INFO - PID 13085 | [#2] jquery.html Cycles:180 Average:39324.57 Median:2259.51 stddev:97129.89 (4298.7%) stddev-sans-first:97358.73 11:44:32 INFO - PID 13085 | Values: 548.8 553.3 569.6 572.3 582.7 22565.1 23163.8 23212.9 23261.4 23469.0 26746.3 27241.0 27269.0 27287.9 27316.7 6208.5 6380.8 6382.9 6387.3 6396.3 6101.4 6135.9 6335.5 6358.8 6366.6 6294.2 6322.6 6324.7 6327.4 6335.2 6333.6 6334.2 6344.4 6346.3 6352.2 5863.0 5872.2 5876.1 5879.6 5892.1 30180.2 30964.2 31061.4 31176.5 31406.7 2228.3 2258.5 2259.5 2259.5 2267.7 20195.2 20759.0 20763.5 20768.8 20783.4 2450.7 2501.4 2539.4 2542.6 2547.4 151959.0 156191.0 160496.0 160555.0 160870.0 15294.3 15567.3 15828.6 15913.4 15924.8 23362.3 23560.5 23594.9 23612.4 24035.5 10655.8 10670.3 10703.5 10757.4 10971.9 9951.4 9973.5 10000.6 10079.8 10226.2 9649.4 9728.7 9757.6 9890.8 10141.3 2639.2 2672.2 2747.0 2799.5 2897.7 1050.3 1064.0 1074.5 1083.4 1105.1 21668.5 21833.0 22009.6 22021.2 22072.8 1146.4 1147.3 1149.3 1154.2 1155.9 11671.2 12308.0 12320.5 12351.4 12372.9 531629.0 534826.0 594612.0 605172.0 607665.0 132597.0 140383.0 140407.3 141347.0 142533.3 1318.2 1324.9 1369.9 1370.9 1378.6 22468.7 22554.4 22581.5 22933.5 23308.2 62146.4 62524.7 62952.0 64423.7 66125.7 74455.3 74637.0 75124.0 75592.2 75652.6 14805.7 15318.5 15390.2 15425.4 15473.2 24237.5 24323.0 24608.0 24703.0 24957.5 19878.4 19902.7 19950.4 20121.2 20245.9 17417.8 17560.6 17989.6 18165.4 18549.7 19948.3 20393.8 20494.3 20572.3 20597.8 14877.7 14896.9 14981.4 15009.4 15150.9 19648.5 19761.7 20016.5 20054.6 20117.5 11:44:32 INFO - PID 13085 | 11:44:32 INFO - PID 13085 | [#3] mootools.html Cycles:180 Average:10136.80 Median:2551.30 stddev:7393.95 (289.8%) stddev-sans-first:7385.85 11:44:32 INFO - PID 13085 | Values: 1445.4 1511.7 1514.9 1530.4 1531.4 15824.6 16430.7 16455.8 16457.5 16462.9 15783.5 16245.4 16939.3 16955.6 16958.6 2601.8 2660.6 2661.7 2663.7 2664.8 2596.9 2648.8 2671.9 2708.8 2714.6 2697.4 2723.9 2732.2 2732.5 2733.0 2633.0 2649.1 2651.7 2658.6 2662.2 2551.2 2551.4 2561.0 2564.3 2565.4 15682.6 15974.8 15976.7 15982.4 15997.8 7996.2 8266.0 8269.5 8271.3 8275.9 5256.8 5266.4 5380.6 5418.7 5434.2 1921.5 1934.8 1936.5 1977.6 1978.5 28707.6 28886.3 29088.0 29136.7 29393.3 6451.5 6950.1 7025.6 7112.8 7200.6 18669.3 18901.4 18943.9 19863.6 19889.5 7901.0 8027.9 8111.2 8122.6 8123.1 7355.3 7420.6 7447.3 7471.3 7566.5 5184.9 5427.5 5428.1 5430.5 5446.6 1555.7 1565.8 1567.6 1582.4 1599.3 954.2 974.0 984.0 1000.0 1005.8 8413.2 8458.8 8511.2 8541.7 8640.6 714.7 754.7 1035.6 1041.1 1047.6 6189.9 6552.3 6688.6 6927.4 6944.1 23197.4 23235.4 24153.9 24208.8 24212.5 22845.0 23439.9 23516.9 23636.4 23639.5 12427.2 12759.4 12779.2 12981.3 13032.5 9546.6 9569.1 9572.5 9608.5 9860.2 20446.9 20508.6 20575.6 20805.4 21463.4 20939.8 20970.6 21103.2 21218.6 21707.6 13095.7 13446.8 13454.3 13457.4 13461.5 14618.7 14980.8 15132.2 15137.0 15184.9 11658.4 11831.9 11917.8 12056.2 12112.7 11589.4 11722.8 11778.8 11898.5 11969.6 10560.9 10705.3 10715.9 10729.7 10738.5 8327.3 8359.5 8380.9 8451.1 8479.7 8228.0 8235.5 8235.7 8251.6 8315.3 11:44:32 INFO - PID 13085 | 11:44:32 INFO - PID 13085 | [#4] prototype.html Cycles:180 Average:5501.54 Median:6152.65 stddev:1576.74 (25.6%) stddev-sans-first:1535.95 11:44:32 INFO - PID 13085 | Values: 506.7 515.2 529.3 541.3 544.9 6034.9 6139.7 6149.5 6155.8 6172.8 6015.7 6019.6 6033.8 6056.2 6063.2 4736.7 4739.2 4768.3 4768.4 4774.7 4650.6 4721.0 4757.0 4780.9 4782.0 4725.4 4731.1 4750.6 4752.8 4817.8 4704.2 4720.9 4750.8 4763.6 4774.5 4250.7 4271.2 4321.9 4333.9 4343.0 5867.4 5917.1 5927.4 6018.7 6019.9 5565.9 5590.9 5667.0 5674.1 5699.9 6364.0 6399.2 6438.4 6457.7 6488.5 4817.3 4822.0 4849.0 4869.4 4895.7 6624.4 6729.4 6736.8 6817.7 6890.4 4966.2 4986.9 5008.9 5021.4 5061.8 5078.3 5098.3 5098.5 5102.4 5104.8 5578.4 5621.6 5629.3 5670.2 5678.0 6288.3 6375.5 6377.7 6436.7 6461.8 1709.3 1737.2 1745.8 1755.5 1756.3 1084.6 1207.9 1220.5 1235.0 1259.8 6033.5 6100.7 6183.0 6207.8 6245.2 6507.3 6559.8 6632.8 6654.5 6689.1 6218.2 6229.5 6255.3 6279.7 6328.7 3469.2 3473.9 3474.6 3512.4 3530.0 6881.3 6881.4 6916.8 7004.1 7037.0 6708.3 6716.2 6777.4 6785.6 6844.0 6914.0 6960.5 6984.5 6990.3 7030.8 6527.5 6591.6 6621.2 6662.7 6690.2 6486.4 6539.7 6584.6 6644.8 6674.8 6919.9 6939.9 6988.7 6999.1 7062.3 5036.0 5042.2 5058.7 5082.8 5088.7 6600.2 6656.7 6694.4 6757.6 6792.8 6411.9 6412.8 6460.6 6482.7 6526.3 6438.2 6446.0 6513.3 6525.6 6573.3 6439.9 6442.6 6478.6 6496.5 6509.5 5945.9 6535.6 6547.6 6573.7 6605.3 6289.0 6327.8 6348.2 6351.3 6359.6 11:44:32 INFO - PID 13085 | 11:44:32 INFO - PID 13085 | [#5] yui.html Cycles:180 Average:27573.31 Median:20987.66 stddev:38005.96 (181.1%) stddev-sans-first:38059.93 11:44:32 INFO - PID 13085 | Values: 934.3 943.4 951.8 958.9 977.0 18867.5 19781.7 19791.4 19848.3 22612.9 21915.6 21977.7 22048.0 22066.3 22073.6 1076.5 1102.4 1106.7 1109.1 1110.7 1014.3 1031.7 1076.2 1084.0 1093.4 1143.0 1154.2 1154.8 1155.5 1155.7 1142.4 1149.4 1150.2 1151.3 1155.7 835.3 843.0 843.0 843.6 845.0 18889.3 18905.0 18948.7 20403.8 21577.4 22615.2 22780.7 23281.3 23324.9 23658.5 17570.0 17836.6 17844.6 18144.2 18274.0 3628.0 3645.9 3648.9 3650.9 3651.5 136593.3 137518.3 137965.3 138767.0 139725.0 18003.0 18524.4 18555.7 18616.7 18679.4 33986.8 34155.1 34804.5 35060.3 35088.3 9148.4 9255.6 9270.3 9284.1 9291.4 4666.8 4743.4 4744.1 4749.1 4749.6 5453.9 5563.5 5632.4 5634.1 5634.2 1140.3 1160.5 1172.4 1175.1 1175.8 679.2 690.4 699.5 709.6 750.3 12749.8 14825.3 15117.7 15192.0 16409.3 729.5 733.2 750.4 751.7 763.2 6346.1 6587.4 6638.2 6677.2 6697.0 128223.4 129176.2 138271.0 139483.0 142702.0 109148.0 111634.0 116623.4 117855.0 123792.0 105629.5 105688.9 106277.0 107517.0 109655.5 13685.1 14347.9 14414.9 14611.6 14744.3 48618.0 49381.3 50157.7 50297.0 50873.5 81358.6 84404.6 84697.6 84834.2 86267.0 20358.0 20895.6 21053.7 21097.7 21234.6 24180.4 24212.6 24374.6 24442.9 24455.3 20982.2 21050.4 21103.6 21204.6 21833.1 20496.8 20646.6 20972.1 21001.4 21011.7 19812.4 20626.1 20993.2 21413.4 21592.0 14710.9 14909.0 15241.5 15264.8 15596.7 12218.1 13043.1 15345.2 16174.0 16538.7 11:44:32 INFO - PID 13085 | -------- Summary: end -------- 11:44:32 INFO - PID 13085 | 11:44:33 INFO - TEST-INFO | 13085: exit 0 11:44:33 INFO - TEST-OK | dromaeo_css | took 1108150ms 11:44:33 INFO - TEST-START | kraken 11:44:33 INFO - Initialising browser for kraken test... 11:44:33 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:36250/getInfo.html -profile /tmp/tmp46OOll/profile 11:44:33 INFO - TEST-INFO | started process 13457 (/builds/slave/test/build/application/firefox/firefox http://localhost:36250/getInfo.html) 11:44:38 INFO - TEST-INFO | 13457: exit 0 11:44:39 INFO - Browser initialized. 11:44:39 INFO - Running cycle 1/1 for kraken test... 11:44:39 INFO - TEST-INFO | started process 13633 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp46OOll/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 11:44:39 INFO - PID 13633 | 11:44:39 INFO - PID 13633 | (/builds/slave/test/build/application/firefox/firefox:13681): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 11:44:39 INFO - PID 13633 | 11:44:50 INFO - PID 13633 | RSS: Main: 157409280 11:44:50 INFO - PID 13633 | 11:44:52 INFO - PID 13633 | Cycle 1(1): loaded http://localhost:36250/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:36250/tests/kraken/driver.html?testName=audio-beat-detection) 11:44:53 INFO - PID 13633 | RSS: Main: 164290560 11:44:53 INFO - PID 13633 | 11:44:56 INFO - PID 13633 | Cycle 1(1): loaded http://localhost:36250/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:36250/tests/kraken/driver.html?testName=audio-dft) 11:44:56 INFO - PID 13633 | RSS: Main: 168091648 11:44:56 INFO - PID 13633 | 11:44:59 INFO - PID 13633 | Cycle 1(1): loaded http://localhost:36250/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:36250/tests/kraken/driver.html?testName=audio-fft) 11:45:00 INFO - PID 13633 | RSS: Main: 160911360 11:45:00 INFO - PID 13633 | 11:45:02 INFO - PID 13633 | Cycle 1(1): loaded http://localhost:36250/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:36250/tests/kraken/driver.html?testName=audio-oscillator) 11:45:03 INFO - PID 13633 | RSS: Main: 161583104 11:45:03 INFO - PID 13633 | 11:45:05 INFO - PID 13633 | Cycle 1(1): loaded http://localhost:36250/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:36250/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:45:05 INFO - PID 13633 | RSS: Main: 161837056 11:45:05 INFO - PID 13633 | 11:45:08 INFO - PID 13633 | Cycle 1(1): loaded http://localhost:36250/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:36250/tests/kraken/driver.html?testName=imaging-darkroom) 11:45:09 INFO - PID 13633 | RSS: Main: 163581952 11:45:09 INFO - PID 13633 | 11:45:12 INFO - PID 13633 | Cycle 1(1): loaded http://localhost:36250/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:36250/tests/kraken/driver.html?testName=imaging-desaturate) 11:45:13 INFO - PID 13633 | RSS: Main: 165064704 11:45:13 INFO - PID 13633 | 11:45:16 INFO - PID 13633 | Cycle 1(1): loaded http://localhost:36250/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:36250/tests/kraken/driver.html?testName=json-parse-financial) 11:45:16 INFO - PID 13633 | RSS: Main: 163311616 11:45:16 INFO - PID 13633 | 11:45:18 INFO - PID 13633 | Cycle 1(1): loaded http://localhost:36250/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:36250/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:45:19 INFO - PID 13633 | RSS: Main: 163762176 11:45:19 INFO - PID 13633 | 11:45:20 INFO - PID 13633 | Cycle 1(1): loaded http://localhost:36250/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:36250/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:45:21 INFO - PID 13633 | RSS: Main: 163586048 11:45:21 INFO - PID 13633 | 11:45:23 INFO - PID 13633 | Cycle 1(1): loaded http://localhost:36250/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:36250/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:45:24 INFO - PID 13633 | RSS: Main: 163708928 11:45:24 INFO - PID 13633 | 11:45:26 INFO - PID 13633 | Cycle 1(1): loaded http://localhost:36250/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:36250/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:45:27 INFO - PID 13633 | RSS: Main: 163545088 11:45:27 INFO - PID 13633 | 11:45:30 INFO - PID 13633 | Cycle 1(1): loaded http://localhost:36250/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:36250/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:45:30 INFO - PID 13633 | RSS: Main: 163741696 11:45:30 INFO - PID 13633 | 11:45:32 INFO - PID 13633 | Cycle 1(1): loaded http://localhost:36250/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:36250/tests/kraken/driver.html?testName=ai-astar) 11:45:32 INFO - PID 13633 | RSS: Main: 165855232 11:45:32 INFO - PID 13633 | 11:45:32 INFO - PID 13633 | __start_tp_report 11:45:32 INFO - PID 13633 | _x_x_mozilla_page_load 11:45:32 INFO - PID 13633 | _x_x_mozilla_page_load_details 11:45:32 INFO - PID 13633 | |i|pagename|runs| 11:45:32 INFO - PID 13633 | |0;ai-astar;96;107;100;106;106;107;106;98;105;107 11:45:32 INFO - PID 13633 | |1;audio-beat-detection;144;111;139;170;114;139;154;114;174;115 11:45:32 INFO - PID 13633 | |2;audio-dft;163;162;162;162;162;161;162;160;167;172 11:45:32 INFO - PID 13633 | |3;audio-fft;73;72;76;109;73;73;73;85;93;74 11:45:32 INFO - PID 13633 | |4;audio-oscillator;77;79;139;78;78;78;123;78;78;128 11:45:32 INFO - PID 13633 | |5;imaging-gaussian-blur;114;114;114;115;114;115;114;113;113;115 11:45:32 INFO - PID 13633 | |6;imaging-darkroom;147;148;147;148;148;147;148;147;149;149 11:45:32 INFO - PID 13633 | |7;imaging-desaturate;95;95;94;94;94;94;94;94;95;94 11:45:32 INFO - PID 13633 | |8;json-parse-financial;48;48;49;50;50;47;53;48;47;49 11:45:32 INFO - PID 13633 | |9;json-stringify-tinderbox;55;55;55;55;57;55;55;55;55;56 11:45:32 INFO - PID 13633 | |10;stanford-crypto-aes;73;75;72;71;71;72;71;73;71;74 11:45:32 INFO - PID 13633 | |11;stanford-crypto-ccm;123;112;111;111;118;120;111;112;114;180 11:45:32 INFO - PID 13633 | |12;stanford-crypto-pbkdf2;162;161;162;160;159;166;159;157;159;160 11:45:32 INFO - PID 13633 | |13;stanford-crypto-sha256-iterative;62;62;63;60;59;59;61;62;59;60 11:45:32 INFO - PID 13633 | __end_tp_report 11:45:32 INFO - PID 13633 | __start_cc_report 11:45:32 INFO - PID 13633 | _x_x_mozilla_cycle_collect,849 11:45:32 INFO - PID 13633 | __end_cc_report 11:45:32 INFO - PID 13633 | __startTimestamp1502995532654__endTimestamp 11:45:32 INFO - PID 13633 | 11:45:32 INFO - PID 13633 | ------- Summary: start ------- 11:45:32 INFO - PID 13633 | Number of tests: 14 11:45:32 INFO - PID 13633 | 11:45:32 INFO - PID 13633 | [#0] ai-astar Cycles:10 Average:103.80 Median:107.00 stddev:4.16 (3.9%) stddev-sans-first:3.32 11:45:32 INFO - PID 13633 | Values: 96.0 107.0 100.0 106.0 106.0 107.0 106.0 98.0 105.0 107.0 11:45:32 INFO - PID 13633 | 11:45:32 INFO - PID 13633 | [#1] audio-beat-detection Cycles:10 Average:137.40 Median:141.50 stddev:23.62 (16.7%) stddev-sans-first:24.93 11:45:32 INFO - PID 13633 | Values: 144.0 111.0 139.0 170.0 114.0 139.0 154.0 114.0 174.0 115.0 11:45:32 INFO - PID 13633 | 11:45:32 INFO - PID 13633 | [#2] audio-dft Cycles:10 Average:163.30 Median:162.00 stddev:3.56 (2.2%) stddev-sans-first:3.77 11:45:32 INFO - PID 13633 | Values: 163.0 162.0 162.0 162.0 162.0 161.0 162.0 160.0 167.0 172.0 11:45:32 INFO - PID 13633 | 11:45:32 INFO - PID 13633 | [#3] audio-fft Cycles:10 Average:80.10 Median:73.50 stddev:12.23 (16.6%) stddev-sans-first:12.70 11:45:32 INFO - PID 13633 | Values: 73.0 72.0 76.0 109.0 73.0 73.0 73.0 85.0 93.0 74.0 11:45:32 INFO - PID 13633 | 11:45:32 INFO - PID 13633 | [#4] audio-oscillator Cycles:10 Average:93.60 Median:78.00 stddev:25.42 (32.6%) stddev-sans-first:26.24 11:45:32 INFO - PID 13633 | Values: 77.0 79.0 139.0 78.0 78.0 78.0 123.0 78.0 78.0 128.0 11:45:32 INFO - PID 13633 | 11:45:32 INFO - PID 13633 | [#5] imaging-gaussian-blur Cycles:10 Average:114.10 Median:114.00 stddev:0.74 (0.6%) stddev-sans-first:0.78 11:45:32 INFO - PID 13633 | Values: 114.0 114.0 114.0 115.0 114.0 115.0 114.0 113.0 113.0 115.0 11:45:32 INFO - PID 13633 | 11:45:32 INFO - PID 13633 | [#6] imaging-darkroom Cycles:10 Average:147.80 Median:148.00 stddev:0.79 (0.5%) stddev-sans-first:0.78 11:45:32 INFO - PID 13633 | Values: 147.0 148.0 147.0 148.0 148.0 147.0 148.0 147.0 149.0 149.0 11:45:32 INFO - PID 13633 | 11:45:32 INFO - PID 13633 | [#7] imaging-desaturate Cycles:10 Average:94.30 Median:94.00 stddev:0.48 (0.5%) stddev-sans-first:0.44 11:45:32 INFO - PID 13633 | Values: 95.0 95.0 94.0 94.0 94.0 94.0 94.0 94.0 95.0 94.0 11:45:32 INFO - PID 13633 | 11:45:32 INFO - PID 13633 | [#8] json-parse-financial Cycles:10 Average:48.90 Median:49.00 stddev:1.79 (3.7%) stddev-sans-first:1.87 11:45:32 INFO - PID 13633 | Values: 48.0 48.0 49.0 50.0 50.0 47.0 53.0 48.0 47.0 49.0 11:45:32 INFO - PID 13633 | 11:45:32 INFO - PID 13633 | [#9] json-stringify-tinderbox Cycles:10 Average:55.30 Median:55.00 stddev:0.67 (1.2%) stddev-sans-first:0.71 11:45:32 INFO - PID 13633 | Values: 55.0 55.0 55.0 55.0 57.0 55.0 55.0 55.0 55.0 56.0 11:45:32 INFO - PID 13633 | 11:45:32 INFO - PID 13633 | [#10] stanford-crypto-aes Cycles:10 Average:72.30 Median:72.50 stddev:1.42 (2.0%) stddev-sans-first:1.48 11:45:32 INFO - PID 13633 | Values: 73.0 75.0 72.0 71.0 71.0 72.0 71.0 73.0 71.0 74.0 11:45:32 INFO - PID 13633 | 11:45:32 INFO - PID 13633 | [#11] stanford-crypto-ccm Cycles:10 Average:121.20 Median:116.00 stddev:21.10 (18.2%) stddev-sans-first:22.37 11:45:32 INFO - PID 13633 | Values: 123.0 112.0 111.0 111.0 118.0 120.0 111.0 112.0 114.0 180.0 11:45:32 INFO - PID 13633 | 11:45:32 INFO - PID 13633 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:160.50 Median:160.50 stddev:2.46 (1.5%) stddev-sans-first:2.55 11:45:32 INFO - PID 13633 | Values: 162.0 161.0 162.0 160.0 159.0 166.0 159.0 157.0 159.0 160.0 11:45:32 INFO - PID 13633 | 11:45:32 INFO - PID 13633 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:60.70 Median:61.50 stddev:1.49 (2.4%) stddev-sans-first:1.51 11:45:32 INFO - PID 13633 | Values: 62.0 62.0 63.0 60.0 59.0 59.0 61.0 62.0 59.0 60.0 11:45:32 INFO - PID 13633 | -------- Summary: end -------- 11:45:32 INFO - PID 13633 | 11:45:33 INFO - PID 13633 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 11:45:33 INFO - TEST-INFO | 13633: exit 0 11:45:33 INFO - TEST-OK | kraken | took 59966ms 11:45:33 INFO - SUITE-END | took 1168s 11:45:33 INFO - Completed test suite (00:19:28) 11:45:33 INFO - javascript benchmark 11:45:33 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8801.614168790502, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3477.982610086949, 3502.1944952660897, 3510.2979404119164, 3516.3846326892785, 3541.2386336937557, 6189.7524099036045, 6319.684015799209, 6336.176297081373, 6339.30267670557, 6387.393197646222, 6169.043798211284, 6259.280182778982, 6265.091561723559, 6283.622982621046, 6369.4585960193435, 5507.394186639486, 5513.476219759116, 5551.333839939192, 5586.888262234763, 5588.832335029955, 318.4436068714158, 5470.261514695525, 5476.698781567012, 5626.521745651604, 5628.43715628438, 5461.481159289861, 5502.972485137549, 5581.748821303051, 5584.246126772874, 5585.05054140795, 5499.175123731432, 5502.257195278627, 5562.721863906829, 5574.637648552831, 5576.302962129734, 5448.4279150689, 5458.4814442627885, 5512.641678290938, 5527.336719593634, 5533.557315414757, 6202.224721909762, 6207.037909124093, 6241.313455519889, 6269.341719119518, 6296.496280297565, 6630.403263706289, 6751.25736169021, 6770.289119642465, 6781.593104413751, 6867.690953907087, 6781.355771201728, 6874.106366172366, 6894.24163342032, 6948.5483443576, 6973.12835895513, 6317.968410157966, 6331.366863313678, 6331.683415829236, 6333.429991300805, 6338.841528961767, 7043.9647801761685, 7044.823879402953, 7094.432445404355, 7117.252688467636, 7124.50128491011, 6604.636744978976, 6708.932910670928, 6743.494237932175, 6784.966075169691, 6800.965995169992, 6801.625910574966, 6817.318268173143, 6820.761273355409, 6829.556078854858, 6829.897551536731, 6836.6923488443135, 6837.213720422115, 6840.794776156723, 6851.931480685229, 6872.896906546406, 6643.7674681385915, 6878.759243426456, 6886.965565172142, 6889.793306200822, 6891.517593768388, 4911.336969509142, 4919.950800491949, 4922.778474968635, 4956.306117143603, 4970.975145124324, 4411.029573493826, 4417.315316126005, 4417.734935903792, 4440.111977604492, 4452.065066336041, 6439.871202575922, 6448.1295025171, 6448.613083215022, 6516.674166291667, 6562.8359291018105, 6737.0, 6807.149106361705, 6847.931520684829, 6867.828304292333, 6892.827679307957, 6523.869522609616, 6525.641089740015, 6541.967290163519, 6546.149000629983, 6553.279139294674, 5479.479449452296, 5509.972450137724, 5530.5022547970075, 5533.667979921218, 5538.390777014525, 7129.0, 7147.499675022803, 7219.566825990458, 7262.092238470192, 7265.600391978386, 6851.45188384928, 6855.725770969106, 6923.065386173003, 6931.618760968095, 6935.133108361455, 7026.718931242693, 7037.049998250171, 7176.605286709072, 7178.461615378972, 7279.963600181965, 6706.798796036127, 6715.899261510984, 6729.528932974645, 6731.831704207434, 6817.829554261183, 6864.897026544706, 6865.656717164022, 6888.724451021903, 6936.167659880846, 6955.061066755923, 6569.704363303758, 6651.301613330531, 6708.060871477899, 6709.228438729609, 6729.528932974645, 6608.693917847631, 6626.469882409299, 6627.37039981201, 6713.832154196184, 6735.4274886635185, 6562.081308616893, 6663.766768163285, 6668.066470694203, 6710.899336509859, 6737.663116844236, 6716.630585317855, 6734.797956061326, 6743.393094621508, 6782.626955517494, 6805.829854253683, 6529.347065293433, 6572.507061970276, 6583.934160658524, 6603.141591593062, 6626.734930602915], "value": 6177.6469808961465, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [864.1584993149961, 897.5512243878065, 926.9443833369997, 949.4303417949227, 953.0612346838363, 42496.78751606242, 43737.0, 43747.12505749883, 43828.12343753123, 44023.0, 41270.79364603173, 41545.16909661813, 41667.0, 41685.0, 41717.582824171746, 6803.829904252396, 6913.965430172842, 6914.343137401939, 6915.308469153095, 6919.65401729914, 6837.829054273658, 6914.412274956635, 6915.997180408837, 6916.2737912519215, 6991.0, 6970.4075153612, 6996.650167491631, 6996.7201311947465, 6998.405135563457, 6998.510104292702, 6930.653467326639, 6960.79117626472, 6964.825879353006, 6966.860662786716, 6971.128608923885, 6339.524535659844, 6393.616383016987, 6394.680265986682, 6397.648129352884, 6399.9360006400275, 35650.10874728153, 35659.0, 35916.0, 35919.102022449646, 35971.64028359709, 3357.3956687796185, 3389.983050084734, 3392.406328892434, 3393.321335732863, 3401.6088149862835, 27986.580201296998, 28033.859830700716, 28074.2981425466, 28108.0, 28175.718242817515, 4431.468223813131, 4452.933206001912, 4465.776711164462, 4479.753613551254, 4486.955130448687, 200700.99999999854, 201156.0, 201328.0, 201997.0, 202588.0, 22536.436589085402, 22727.204547841076, 22734.431639208822, 22766.65850012251, 22812.885935570215, 23308.067677292718, 23317.650235246485, 23344.533109337717, 23371.0, 23397.7660223399, 13472.932635336761, 13705.383257753425, 13706.24615646149, 13713.794293085612, 13717.794233086512, 13322.333883305795, 13347.265900375573, 13422.530211442749, 13429.261390623415, 13452.192868427926, 5999.460048595647, 6024.518038556905, 6037.275526936708, 6084.513238940963, 6090.23872015998, 2576.3687896465112, 2615.751503607154, 2633.249523885683, 2636.6045093235784, 2657.7342265773655, 1094.6059418609295, 1102.8290614954694, 1104.817705078653, 1110.21729680575, 1110.8444817725524, 25243.116490923097, 25270.873645631655, 25311.873440633048, 25333.873330633596, 25334.239972800846, 1190.0549677818005, 1198.394810620631, 1209.4920133543933, 1219.969500762488, 1224.6632176151452, 13387.397567109503, 13418.597442076752, 13517.256550889599, 13551.25468099264, 13615.52345667897, 235291.0, 249224.0, 252952.0, 253258.0, 253508.0, 49952.0, 50998.235026474635, 55206.44793552093, 56846.147307790416, 56846.43153568411, 1516.4768154986511, 1528.6484108655072, 1548.8606025457539, 1550.9612259693372, 1551.0848599326453, 29347.7065229345, 29458.263543411587, 29517.26206844846, 29808.552871707376, 30098.398032039673, 53898.0, 54401.727991361375, 54456.183157253465, 54499.182512261556, 54520.182197267866, 231392.0, 232507.0, 232565.0, 232840.0, 233114.0, 35479.645203548665, 35681.0, 35741.642583573834, 35815.46276805902, 35955.640443596276, 45077.32384014177, 45156.548434516546, 45177.774111129234, 45303.320450192616, 45527.089458209986, 33923.83038084794, 33998.32003359968, 34188.48717269293, 34425.0, 34714.0, 33658.0, 33887.322253555285, 34118.48822267717, 34164.316713666085, 34545.654543455246, 39374.21251574895, 39441.21117577575, 40011.399829002, 40105.39841902316, 40284.3957340646, 33040.66959330376, 33130.5030424539, 33375.666243337255, 33536.0, 33795.493067603515, 24621.38446538851, 24713.135040273504, 25275.620865686662, 25632.743672563036, 25860.741392586588], "value": 16069.642806125505, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [548.7996881138383, 553.3138907754385, 569.6183557016799, 572.253209561522, 582.7173820696962, 22565.097396104156, 23163.768362316372, 23212.8839355803, 23261.418464538394, 23469.0, 26746.331341716468, 27241.0, 27269.0, 27287.863560682217, 27316.726832731667, 6208.50331973441, 6380.808575742735, 6382.904256436157, 6387.329330420309, 6396.2964073951825, 6101.35935726749, 6135.938640613582, 6335.493160547145, 6358.84102897429, 6366.586171898835, 6294.181756371665, 6322.620642761426, 6324.652144132071, 6327.3988971047675, 6335.208098987627, 6333.55665103443, 6334.176557047577, 6344.397282258178, 6346.30190679025, 6352.237731472207, 5863.0, 5872.207252020965, 5876.08920617305, 5879.647221166701, 5892.086726557391, 30180.24549386283, 30964.225894352596, 31061.37877242465, 31176.53235201474, 31406.685933140605, 2228.2646726580188, 2258.5144193998367, 2259.4690247791755, 2259.5480903819303, 2267.682524446579, 20195.19219231229, 20759.0, 20763.480912977146, 20768.792312076836, 20783.37649870491, 2450.718167410753, 2501.374656335916, 2539.4032402385424, 2542.6058960861096, 2547.3886267295716, 151958.9999999989, 156191.0, 160496.0, 160555.0, 160870.0, 15294.311755971008, 15567.29947152381, 15828.60428489297, 15913.443029493912, 15924.840751592335, 23362.299131026095, 23560.528789424457, 23594.882025589763, 23612.40968975755, 24035.519289614458, 10655.786884262272, 10670.25308228432, 10703.46482675863, 10757.354558726502, 10971.945140274407, 9951.353162044445, 9973.50132493387, 10000.599976001024, 10079.798404031879, 10226.23303252259, 9649.372790768577, 9728.719363480046, 9757.560909759079, 9890.752731181778, 10141.290109692398, 2639.1818536253822, 2672.225054734144, 2747.0, 2799.496090703652, 2897.7392034716977, 1050.2805578178973, 1064.0157853985188, 1074.462768615692, 1083.4420273559124, 1105.1214284643727, 21668.45828854291, 21833.0, 22009.559808803733, 22021.22925697625, 22072.779272207394, 1146.4439746722833, 1147.3058799426226, 1149.2759561476216, 1154.203599516331, 1155.8555180602425, 11671.183017188885, 12308.0, 12320.507179712711, 12351.444185011696, 12372.876271237352, 531629.0, 534826.0, 594612.0, 605172.0, 607665.0, 132597.0, 140383.0, 140407.29796350954, 141347.0, 142533.28733356268, 1318.1695531814896, 1324.8608896065966, 1369.9109557878905, 1370.9383077761524, 1378.5519706095558, 22468.66297005579, 22554.436139096655, 22581.548369032855, 22933.54132917299, 23308.184213552446, 62146.37853621406, 62524.687376562826, 62952.0, 64423.67788161029, 66125.66937165284, 74455.25544744483, 74637.0, 75124.0, 75592.24407756072, 75652.62173689096, 14805.703885922436, 15318.463853765064, 15390.153541555323, 15425.382984680487, 15473.226338683246, 24237.515249694556, 24323.0, 24608.0, 24703.0, 24957.500849983262, 19878.403647890587, 19902.70145947841, 19950.401487955383, 20121.195152194334, 20245.898770506054, 17417.82582174162, 17560.648787023933, 17989.550261243574, 18165.36421225251, 18549.721754173428, 19948.30180943718, 20393.79606203919, 20494.28270010602, 20572.279970200972, 20597.79402205959, 14877.702445951238, 14896.851031489547, 14981.40074397012, 15009.399624014917, 15150.924245378703, 19648.508787280432, 19761.703574446106, 20016.49958751043, 20054.59890802205, 20117.49706257355], "value": 12770.715799433683, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1445.421831267493, 1511.6901035287763, 1514.9394024239025, 1530.380196020612, 1531.4486784757491, 15824.604384890383, 16430.671386572278, 16455.835441645595, 16457.506274811745, 16462.917685411587, 15783.526494205164, 16245.431409900655, 16939.3224271029, 16955.57611059724, 16958.576035599086, 2601.752833480821, 2660.5876089206204, 2661.7072122066556, 2663.73362663734, 2664.760171584557, 2596.8831402586834, 2648.774854137401, 2671.9465610687776, 2708.8374697518116, 2714.6335244741904, 2697.4200546882416, 2723.8638068096616, 2732.248631626299, 2732.4808286425614, 2732.9863350683218, 2632.986835065822, 2649.1390298153083, 2651.655284812962, 2658.617518890176, 2662.1614191529607, 2551.1836212412036, 2551.413174969749, 2560.9871950640313, 2564.2563656539583, 2565.3586603349163, 15682.607934801606, 15974.76037859433, 15976.680466390608, 15982.360705571764, 15997.840021599752, 7996.24035716606, 8265.95867020667, 8269.545175015372, 8271.255586997138, 8275.917240827575, 5256.81601143962, 5266.447023062561, 5380.623356365056, 5418.726599249173, 5434.184872269152, 1921.5388306806406, 1934.84521238302, 1936.4674714453497, 1977.574821413403, 1978.4658142301641, 28707.56938645922, 28886.277843053882, 29088.0, 29136.70863291361, 29393.265168370963, 6451.548391612636, 6950.061741664912, 7025.648717564101, 7112.751053713096, 7200.567965922061, 18669.253229870654, 18901.43295701131, 18943.90528047351, 19863.60272794536, 19889.502762431053, 7901.0, 8027.879581806277, 8111.1888811118415, 8122.593870306461, 8123.065847427503, 7355.301246381585, 7420.628968551551, 7447.292507211914, 7471.290227428385, 7566.470347075762, 5184.8963020739375, 5427.538659213932, 5428.104362780176, 5430.456954304538, 5446.591505637093, 1555.6655319106446, 1565.8434156584478, 1567.5924259692333, 1582.3670531787377, 1599.336689842574, 954.2223088183108, 973.956171972263, 983.9704808855746, 1000.0049950299499, 1005.7636455432968, 8413.158684131538, 8458.788530286669, 8511.191436813493, 8541.658333666708, 8640.611172497127, 714.739120221126, 754.724525548182, 1035.5961175141701, 1041.1150522056191, 1047.607147319755, 6189.907151392733, 6552.279249282575, 6688.632125233159, 6927.445804335641, 6944.097267355211, 23197.42006449852, 23235.419114521934, 24153.879230603736, 24208.757912421002, 24212.515749684906, 22844.971976260775, 23439.88280058623, 23516.882415588156, 23636.40908977255, 23639.527209455715, 12427.192232504858, 12759.42582583786, 12779.23324600527, 12981.286029268482, 13032.54386096482, 9546.61813527479, 9569.138777510057, 9572.473513956798, 9608.519574021131, 9860.211183105477, 20446.897765511076, 20508.589828203054, 20575.588488230453, 20805.375838724864, 21463.356099317047, 20939.790602093784, 20970.580588388453, 21103.155873764877, 21218.57562848765, 21707.565848683254, 13095.672608184872, 13446.798298025342, 13454.26001569923, 13457.394417251051, 13461.461541538229, 14618.707625847212, 14980.775288370902, 15132.167730774472, 15137.0, 15184.924075379553, 11658.358790266617, 11831.881681183078, 11917.82123268169, 12056.216345937486, 12112.697182570506, 11589.420528973349, 11722.765544688888, 11778.823317650413, 11898.464569094238, 11969.64091077269, 10560.947195263974, 10705.304155230197, 10715.892841071489, 10729.731756706145, 10738.516766745672, 8327.333813295043, 8359.540225287668, 8380.916190838014, 8451.112633173429, 8479.703210387606, 8228.0, 8235.547044912588, 8235.723462863265, 8251.587420629065, 8315.293200078062], "value": 7110.933137616919, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [506.7213032831944, 515.1860061103457, 529.2722506553488, 541.2611784913589, 544.8855740294538, 6034.8793024139495, 6139.662318572482, 6149.508039356852, 6155.784547540837, 6172.845678858031, 6015.6992150392525, 6019.645579744555, 6033.7888173913925, 6056.152138700585, 6063.181470501481, 4736.69211501253, 4739.241721324589, 4768.308595253686, 4768.380110585619, 4774.665773395864, 4650.604698600606, 4720.952790472103, 4757.0, 4780.856574302777, 4782.0, 4725.362076119732, 4731.148393289207, 4750.643701722384, 4752.76236188191, 4817.78319975602, 4704.247320428749, 4720.858374248761, 4750.762461876927, 4763.595094416979, 4774.49867763885, 4250.682288490547, 4271.209826182135, 4321.9135617287475, 4333.9197185350895, 4343.0, 5867.413258674141, 5917.112433135021, 5927.3776253493625, 6018.6689732064715, 6019.939800601982, 5565.9443405566235, 5590.888182236373, 5667.0, 5674.120511320752, 5699.943000569982, 6364.0, 6399.200099987502, 6438.360272288386, 6457.741690332381, 6488.480921526267, 4817.277408388734, 4821.951780482185, 4849.0, 4869.366982292315, 4895.657303988723, 6624.436922861562, 6729.427998620172, 6736.831579210559, 6817.659117044128, 6890.44876409886, 4966.180580204225, 4986.850394488171, 5008.949910500921, 5021.4225364083595, 5061.772220250097, 5078.289039534468, 5098.260752190911, 5098.5411312982005, 5102.413222479388, 5104.770285337168, 5578.41426650204, 5621.578381621313, 5629.296337957755, 5670.177824215548, 5677.971610141923, 6288.308286088527, 6375.521835862329, 6377.681115944184, 6436.710348034349, 6461.773837915651, 1709.2735587375316, 1737.2008875916968, 1745.8079611242754, 1755.4558086993072, 1756.3062590277025, 1084.6366467233408, 1207.9249467973511, 1220.4690959432676, 1234.950601975929, 1259.7921342978307, 6033.5173186145, 6100.664463454464, 6182.969085154546, 6207.782727604512, 6245.188125543741, 6507.251666058369, 6559.770408035696, 6632.83417914556, 6654.500912431587, 6689.130413046273, 6218.22272215973, 6229.470495007885, 6255.280642726054, 6279.748810047547, 6328.71520781566, 3469.2020835208045, 3473.8784142555396, 3474.6004209515722, 3512.4204506256183, 3529.9823500882844, 6881.277465866112, 6881.380675739108, 6916.757913473004, 7004.124484439445, 7037.0, 6708.3291670833505, 6716.194056713128, 6777.390034896883, 6785.558938668971, 6843.973403989342, 6914.0, 6960.512764106566, 6984.546004509691, 6990.335918087773, 7030.824229394101, 6527.5430719849155, 6591.604503729792, 6621.205455345389, 6662.666866656745, 6690.19717633887, 6486.383793539795, 6539.7384104637185, 6584.637844918384, 6644.83387915306, 6674.766383176566, 6919.861602767815, 6939.930600693929, 6988.720451181895, 6999.055127557918, 7062.258462861531, 5035.974820125876, 5042.1932490802765, 5058.721770302669, 5082.796688132581, 5088.669236499616, 6600.240972288057, 6656.73373065072, 6694.430973367123, 6757.560758550679, 6792.830179245559, 6411.871762564816, 6412.775552855627, 6460.612363258219, 6482.675866206577, 6526.347365263436, 6438.227412710505, 6446.035688051908, 6513.316101809241, 6525.64108974011, 6573.290944354598, 6439.935600644121, 6442.6470441207875, 6478.6436745977535, 6496.512761542997, 6509.511786615928, 5945.910811337747, 6535.57518761279, 6547.574407663486, 6573.704183311666, 6605.306442823435, 6289.000244805482, 6327.778527751507, 6348.191085348753, 6351.30135685065, 6359.554831161774], "value": 5040.272055580549, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [934.308611627396, 943.3538475360496, 951.8096380723857, 958.9184919281861, 976.990230097699, 18867.528311792194, 19781.703274450894, 19791.406257812254, 19848.305309314175, 22612.88693556534, 21915.561688766215, 21977.67033494499, 22048.0, 22066.33800985969, 22073.558528829413, 1076.4617691154422, 1102.40470146121, 1106.7122548137502, 1109.0628418985943, 1110.7389763405592, 1014.3305418423842, 1031.705963800317, 1076.1874784537663, 1084.0027174998982, 1093.4314156638543, 1142.959996400126, 1154.2209008918946, 1154.7517283783984, 1155.5146838327923, 1155.7284038251046, 1142.4173671427548, 1149.4367759797722, 1150.2178518607343, 1151.2746969409302, 1155.7284038251005, 835.2941764209233, 842.9968337678205, 843.0431460292551, 843.5992903370911, 845.0408786027903, 18889.338873139375, 18905.0, 18948.715769263334, 20403.795962040338, 21577.352679419644, 22615.208467703553, 22780.658290125662, 23281.301560953198, 23324.883375583184, 23658.526829463488, 17570.0, 17836.643267134714, 17844.643107137785, 18144.18351174187, 18274.0, 3628.0, 3645.927081458356, 3648.872289469856, 3650.908727281839, 3651.525301710787, 136593.3170334152, 137518.3124084373, 137965.3101734485, 138767.0, 139725.0, 18003.0, 18524.351647692267, 18555.72166417505, 18616.720749188775, 18679.439616811516, 33986.83006584951, 34155.14612134716, 34804.477932831025, 35060.29879402398, 35088.298234035174, 9148.405353651991, 9255.629774808933, 9270.30472714549, 9284.118008789153, 9291.442513449214, 4666.766661666903, 4743.383360163157, 4744.074905393415, 4749.121412538691, 4749.643776716691, 5453.945460545423, 5563.499285064364, 5632.436756324335, 5634.070378387602, 5634.1830434586755, 1140.2645293785463, 1160.5067846165346, 1172.3903570143477, 1175.124532223499, 1175.7589694112687, 679.212113947828, 690.4372936057098, 699.4788882282731, 709.6274455910689, 750.3284560318484, 12749.808752868714, 14825.332860021324, 15117.697646047238, 15192.0, 16409.261583228785, 729.5221629832469, 733.1861633586715, 750.3584435307843, 751.6805357722945, 763.1872056260065, 6346.11154438379, 6587.4071333580205, 6638.20341559016, 6677.198736151596, 6696.966515167393, 128223.35888320499, 129176.19510250703, 138271.0, 139483.0, 142702.0, 109148.0, 111634.0, 116623.41688291675, 117855.0, 123792.0, 105629.47185264024, 105688.94311056945, 106277.0, 107516.99999999843, 109655.45172274247, 13685.131049646692, 14347.856521434653, 14414.85585144135, 14611.561653150422, 14744.336504857522, 48618.0, 49381.25928111153, 50157.74921125371, 50296.99406011932, 50873.49126508687, 81358.59320703358, 84404.57797710971, 84697.57651211704, 84834.15165848509, 86267.0, 20358.0, 20895.582088358453, 21053.684194737398, 21097.683534746684, 21234.57530849405, 24180.39549011289, 24212.63681044821, 24374.634380483953, 24442.87778561167, 24455.266342009767, 20982.160713571287, 21050.368488945354, 21103.57792844104, 21204.575908481434, 21833.126674932824, 20496.79503204949, 20646.58706825885, 20972.056257468757, 21001.369958901258, 21011.68482472795, 19812.405627831187, 20626.071826767533, 20993.160273589496, 21413.419115816385, 21592.0, 14710.926445367704, 14909.0, 15241.466548670744, 15264.771028434805, 15596.68806623884, 12218.083643726579, 13043.086983911415, 15345.156016418758, 16174.0, 16538.66922661516], "value": 10231.136436978213, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1453.3000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 107.0, 100.0, 106.0, 106.0, 107.0, 106.0, 98.0, 105.0, 107.0], "value": 103.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 111.0, 139.0, 170.0, 114.0, 139.0, 154.0, 114.0, 174.0, 115.0], "value": 137.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 162.0, 162.0, 162.0, 162.0, 161.0, 162.0, 160.0, 167.0, 172.0], "value": 163.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 72.0, 76.0, 109.0, 73.0, 73.0, 73.0, 85.0, 93.0, 74.0], "value": 80.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 79.0, 139.0, 78.0, 78.0, 78.0, 123.0, 78.0, 78.0, 128.0], "value": 93.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 114.0, 115.0, 114.0, 115.0, 114.0, 113.0, 113.0, 115.0], "value": 114.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 148.0, 147.0, 148.0, 148.0, 147.0, 148.0, 147.0, 149.0, 149.0], "value": 147.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 94.0, 94.0, 94.0, 94.0, 94.0, 94.0, 95.0, 94.0], "value": 94.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [48.0, 48.0, 49.0, 50.0, 50.0, 47.0, 53.0, 48.0, 47.0, 49.0], "value": 48.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 55.0, 55.0, 55.0, 57.0, 55.0, 55.0, 55.0, 55.0, 56.0], "value": 55.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 75.0, 72.0, 71.0, 71.0, 72.0, 71.0, 73.0, 71.0, 74.0], "value": 72.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [123.0, 112.0, 111.0, 111.0, 118.0, 120.0, 111.0, 112.0, 114.0, 180.0], "value": 121.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 162.0, 160.0, 159.0, 166.0, 159.0, 157.0, 159.0, 160.0], "value": 160.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 63.0, 60.0, 59.0, 59.0, 61.0, 62.0, 59.0, 60.0], "value": 60.7, "unit": "score"}]}]} 11:45:33 INFO - Return code: 0 11:45:33 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:45:33 INFO - # TBPL SUCCESS # 11:45:33 INFO - Running post-action listener: _package_coverage_data 11:45:33 INFO - Running post-action listener: _resource_record_post_action 11:45:33 INFO - [mozharness: 2017-08-17 18:45:33.965408Z] Finished run-tests step (success) 11:45:33 INFO - Running post-run listener: _resource_record_post_run 11:45:34 INFO - Total resource usage - Wall time: 1187s; CPU: 13.0%; Read bytes: 16384; Write bytes: 432197632; Read time: 152; Write time: 337984 11:45:34 INFO - TinderboxPrint: CPU usage
13.0% 11:45:34 INFO - TinderboxPrint: I/O read bytes / time
16,384 / 152 11:45:34 INFO - TinderboxPrint: I/O write bytes / time
432,197,632 / 337,984 11:45:34 INFO - TinderboxPrint: CPU idle
8,229.8 (86.9%) 11:45:34 INFO - TinderboxPrint: CPU user
1,186.3 (12.5%) 11:45:34 INFO - TinderboxPrint: Swap in / out
0 / 0 11:45:34 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 8192; Write bytes: 111042560; Read time: 60; Write time: 119428 11:45:34 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:34 INFO - run-tests - Wall time: 1169s; CPU: 13.0%; Read bytes: 8192; Write bytes: 320499712; Read time: 92; Write time: 218512 11:45:34 INFO - Running post-run listener: _upload_blobber_files 11:45:34 INFO - Blob upload gear active. 11:45:34 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:45:34 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:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 11:45:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 11:45:35 INFO - (blobuploader) - INFO - Open directory for files ... 11:45:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:45:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:45:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:45:41 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:45:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:45:41 INFO - (blobuploader) - INFO - Done attempting. 11:45:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 11:45:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:45:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:45:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 11:45:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:45:42 INFO - (blobuploader) - INFO - Done attempting. 11:45:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 11:45:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:45:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:45:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 11:45:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:45:43 INFO - (blobuploader) - INFO - Done attempting. 11:45:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 11:45:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:45:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:45:43 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 11:45:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:45:43 INFO - (blobuploader) - INFO - Done attempting. 11:45:43 INFO - (blobuploader) - INFO - Iteration through files over. 11:45:43 INFO - Return code: 0 11:45:43 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:45:43 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:45:43 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1d4e7b3bd59e8340728d5228ae8007ccae0316c15ee9e6c4e3bf8bfb8cce0ae8f4d8bf62ee995f8ecf2ea6521b6203e521f5063b74466729d881ceefe30063ce", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6a2f0a9620806ba1ee83c50183b7dff97752ae4c2ea707f8d0056f0a61b9c5d311ff6b5f1eeafac11e354391791d7d82c88b76d8ce36b9a1c53da061d19ebaeb", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/da97860a3c553371f1b94cbc07a62984778ff6fb1be20716badfc05b862cae44885b36648fd229514ab8f2db1595c9199193158323d8b6064a96716de1137db6", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/69c70ba6e8459a6d6aa49d8664f13b94ee32e593000dafae3471c9ec192f95ec794a036260696891f6ed133d089f8a245cddd19d6db288c23c3c9a2a33a22a25"} 11:45:43 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:45:43 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:45:43 INFO - Contents: 11:45:43 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1d4e7b3bd59e8340728d5228ae8007ccae0316c15ee9e6c4e3bf8bfb8cce0ae8f4d8bf62ee995f8ecf2ea6521b6203e521f5063b74466729d881ceefe30063ce", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6a2f0a9620806ba1ee83c50183b7dff97752ae4c2ea707f8d0056f0a61b9c5d311ff6b5f1eeafac11e354391791d7d82c88b76d8ce36b9a1c53da061d19ebaeb", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/da97860a3c553371f1b94cbc07a62984778ff6fb1be20716badfc05b862cae44885b36648fd229514ab8f2db1595c9199193158323d8b6064a96716de1137db6", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/69c70ba6e8459a6d6aa49d8664f13b94ee32e593000dafae3471c9ec192f95ec794a036260696891f6ed133d089f8a245cddd19d6db288c23c3c9a2a33a22a25"} 11:45:43 INFO - Running post-run listener: copy_logs_to_upload_dir 11:45:43 INFO - Copying logs to upload dir... 11:45:43 INFO - mkdir: /builds/slave/test/build/upload/logs 11:45:43 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1247.759000 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2017-08-17 11:45:43.929335) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-17 11:45:43.932830) ========= 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=03627c79f6bb3d1578c4a402000001ba-1502994294.323044-408794288 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1d4e7b3bd59e8340728d5228ae8007ccae0316c15ee9e6c4e3bf8bfb8cce0ae8f4d8bf62ee995f8ecf2ea6521b6203e521f5063b74466729d881ceefe30063ce", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6a2f0a9620806ba1ee83c50183b7dff97752ae4c2ea707f8d0056f0a61b9c5d311ff6b5f1eeafac11e354391791d7d82c88b76d8ce36b9a1c53da061d19ebaeb", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/da97860a3c553371f1b94cbc07a62984778ff6fb1be20716badfc05b862cae44885b36648fd229514ab8f2db1595c9199193158323d8b6064a96716de1137db6", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/69c70ba6e8459a6d6aa49d8664f13b94ee32e593000dafae3471c9ec192f95ec794a036260696891f6ed133d089f8a245cddd19d6db288c23c3c9a2a33a22a25"} build_url:https://queue.taskcluster.net/v1/task/ej7oj6HVS_W6qwoEs3vqHQ/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011521 build_url: 'https://queue.taskcluster.net/v1/task/ej7oj6HVS_W6qwoEs3vqHQ/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1d4e7b3bd59e8340728d5228ae8007ccae0316c15ee9e6c4e3bf8bfb8cce0ae8f4d8bf62ee995f8ecf2ea6521b6203e521f5063b74466729d881ceefe30063ce", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6a2f0a9620806ba1ee83c50183b7dff97752ae4c2ea707f8d0056f0a61b9c5d311ff6b5f1eeafac11e354391791d7d82c88b76d8ce36b9a1c53da061d19ebaeb", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/da97860a3c553371f1b94cbc07a62984778ff6fb1be20716badfc05b862cae44885b36648fd229514ab8f2db1595c9199193158323d8b6064a96716de1137db6", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/69c70ba6e8459a6d6aa49d8664f13b94ee32e593000dafae3471c9ec192f95ec794a036260696891f6ed133d089f8a245cddd19d6db288c23c3c9a2a33a22a25"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-17 11:45:43.960344) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-17 11:45:43.960720) ========= 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=03627c79f6bb3d1578c4a402000001ba-1502994294.323044-408794288 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004648 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-17 11:45:44.049018) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-17 11:45:44.049821) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-17 11:45:44.050523) ========= ========= Total master_lag: 0.19 =========