builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-062 starttime: 1503014834.73 results: success (0) revision: a6a1f5c1d971dbee67ba6eec7ead7902351ddca2 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-08-17 17:07:14.728751) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-08-17 17:07:14.729260) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-17 17:07:14.729606) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-17 17:07:14.745732) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-17 17:07:14.746038) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1503014834.80210-986790238 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-08-17 17:07:14-- 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% 46.1M=0s 2017-08-17 17:07:14 (46.1 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.124771 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-17 17:07:14.886672) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-17 17:07:14.887044) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1503014834.80210-986790238 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015823 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-17 17:07:14.937506) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-17 17:07:14.937871) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev a6a1f5c1d971dbee67ba6eec7ead7902351ddca2 --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 a6a1f5c1d971dbee67ba6eec7ead7902351ddca2 --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=a4ce256d2ec601f24a60a71e000001bc-1503014834.80210-986790238 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-08-17 17:07:15,059 truncating revision to first 12 chars 2017-08-17 17:07:15,059 Setting DEBUG logging. 2017-08-17 17:07:15,059 attempt 1/10 2017-08-17 17:07:15,059 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/a6a1f5c1d971?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-08-17 17:07:15,559 unpacking tar archive at: mozilla-central-a6a1f5c1d971/testing/mozharness/ program finished with exit code 0 elapsedTime=0.818180 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-17 17:07:15.770857) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-17 17:07:15.771169) ========= script_repo_revision: a6a1f5c1d971dbee67ba6eec7ead7902351ddca2 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-17 17:07:15.771579) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-17 17:07:15.771861) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-17 17:07:15.782563) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2017-08-17 17:07:15.782847) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=a4ce256d2ec601f24a60a71e000001bc-1503014834.80210-986790238 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:07:16 INFO - MultiFileLogger online at 20170817 17:07:16 in /builds/slave/test 17:07:16 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 17:07:16 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:07:16 INFO - {'append_to_log': False, 17:07:16 INFO - 'base_work_dir': '/builds/slave/test', 17:07:16 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 17:07:16 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:07:16 INFO - 'branch': 'Firefox-Non-PGO', 17:07:16 INFO - 'buildbot_json_path': 'buildprops.json', 17:07:16 INFO - 'code_coverage': False, 17:07:16 INFO - 'config_files': ('talos/linux_config.py',), 17:07:16 INFO - 'default_actions': ('clobber', 17:07:16 INFO - 'read-buildbot-config', 17:07:16 INFO - 'download-and-extract', 17:07:16 INFO - 'populate-webroot', 17:07:16 INFO - 'create-virtualenv', 17:07:16 INFO - 'install', 17:07:16 INFO - 'setup-mitmproxy', 17:07:16 INFO - 'run-tests'), 17:07:16 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:07:16 INFO - 'disable_ccov_upload': False, 17:07:16 INFO - 'download_minidump_stackwalk': True, 17:07:16 INFO - 'download_symbols': 'ondemand', 17:07:16 INFO - 'enable_stylo': False, 17:07:16 INFO - 'enable_webrender': False, 17:07:16 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:07:16 INFO - 'tooltool.py': '/tools/tooltool.py', 17:07:16 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:07:16 INFO - '/tools/misc-python/virtualenv.py')}, 17:07:16 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:07:16 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:07:16 INFO - 'gecko_profile': False, 17:07:16 INFO - 'gecko_profile_interval': 0, 17:07:16 INFO - 'installer_path': 'installer.exe', 17:07:16 INFO - 'log_level': 'info', 17:07:16 INFO - 'log_name': 'talos', 17:07:16 INFO - 'log_to_console': True, 17:07:16 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:07:16 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:07:16 INFO - 'opt_config_files': (), 17:07:16 INFO - 'pip_index': False, 17:07:16 INFO - 'suite': 'dromaeojs-e10s', 17:07:16 INFO - 'system_bits': '32', 17:07:16 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:07:16 INFO - 'title': 'talos-linux64-ix-062', 17:07:16 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:07:16 INFO - 'use_talos_json': True, 17:07:16 INFO - 'verify': 'False', 17:07:16 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:07:16 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:07:16 INFO - 'work_dir': 'build'} 17:07:16 INFO - [mozharness: 2017-08-18 00:07:16.048117Z] Running clobber step. 17:07:16 INFO - Running pre-action listener: _resource_record_pre_action 17:07:16 INFO - Running main action method: clobber 17:07:16 INFO - rmtree: /builds/slave/test/build 17:07:16 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:07:17 INFO - Running post-action listener: _resource_record_post_action 17:07:17 INFO - [mozharness: 2017-08-18 00:07:17.679951Z] Finished clobber step (success) 17:07:17 INFO - [mozharness: 2017-08-18 00:07:17.680048Z] Running read-buildbot-config step. 17:07:17 INFO - Running pre-action listener: _resource_record_pre_action 17:07:17 INFO - Running main action method: read_buildbot_config 17:07:17 INFO - Using buildbot properties: 17:07:17 INFO - { 17:07:17 INFO - "project": "", 17:07:17 INFO - "product": "firefox", 17:07:17 INFO - "who": "kwierso@gmail.com", 17:07:17 INFO - "installer_path": "public/build/target.tar.bz2", 17:07:17 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 17:07:17 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 17:07:17 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 17:07:17 INFO - "stage_platform": "linux64", 17:07:17 INFO - "basedir": "/builds/slave/test", 17:07:17 INFO - "buildnumber": 1084, 17:07:17 INFO - "platform": "ubuntu64_hw", 17:07:17 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 17:07:17 INFO - "slavebuilddir": "test", 17:07:17 INFO - "taskId": "SkfJ_7n0RpaOLQNYeXEeow", 17:07:17 INFO - "branch": "mozilla-central", 17:07:17 INFO - "script_repo_revision": "production", 17:07:17 INFO - "revision": "a6a1f5c1d971dbee67ba6eec7ead7902351ddca2", 17:07:17 INFO - "slavename": "talos-linux64-ix-062", 17:07:17 INFO - "repo_path": "mozilla-central" 17:07:17 INFO - } 17:07:17 INFO - Finding installer, test and symbols from parent task. 17:07:17 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/SkfJ_7n0RpaOLQNYeXEeow'}, attempt #1 17:07:18 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/SkfJ_7n0RpaOLQNYeXEeow'}, attempt #1 17:07:18 INFO - Task dependencies: b0RIcHGxQVmCDF_P3NNDKg 17:07:18 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/b0RIcHGxQVmCDF_P3NNDKg'}, attempt #1 17:07:19 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/b0RIcHGxQVmCDF_P3NNDKg/artifacts/public/build/target.tar.bz2 17:07:19 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/b0RIcHGxQVmCDF_P3NNDKg/artifacts/public/build/target.test_packages.json 17:07:19 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/b0RIcHGxQVmCDF_P3NNDKg/artifacts/public/build/target.crashreporter-symbols.zip 17:07:19 INFO - Running post-action listener: _resource_record_post_action 17:07:19 INFO - [mozharness: 2017-08-18 00:07:19.058648Z] Finished read-buildbot-config step (success) 17:07:19 INFO - [mozharness: 2017-08-18 00:07:19.058863Z] Running download-and-extract step. 17:07:19 INFO - Running pre-action listener: _resource_record_pre_action 17:07:19 INFO - Running main action method: download_and_extract 17:07:19 INFO - mkdir: /builds/slave/test/build/tests 17:07:19 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')]} 17:07:19 INFO - trying https://queue.taskcluster.net/v1/task/b0RIcHGxQVmCDF_P3NNDKg/artifacts/public/build/target.test_packages.json 17:07:19 INFO - Downloading https://queue.taskcluster.net/v1/task/b0RIcHGxQVmCDF_P3NNDKg/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 17:07:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/b0RIcHGxQVmCDF_P3NNDKg/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 17:07:19 INFO - Downloaded 989 bytes. 17:07:19 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 17:07:19 INFO - Using the following test package requirements: 17:07:19 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 17:07:19 INFO - u'common': [u'target.common.tests.zip'], 17:07:19 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 17:07:19 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 17:07:19 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 17:07:19 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 17:07:19 INFO - u'mozbase': [u'target.common.tests.zip'], 17:07:19 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 17:07:19 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 17:07:19 INFO - u'web-platform': [u'target.common.tests.zip', 17:07:19 INFO - u'target.web-platform.tests.tar.gz'], 17:07:19 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 17:07:19 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 17:07:19 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/b0RIcHGxQVmCDF_P3NNDKg/artifacts/public/build/target.common.tests.zip 17:07:19 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/b0RIcHGxQVmCDF_P3NNDKg/artifacts/public/build/target.common.tests.zip'}, attempt #1 17:07:19 INFO - Fetch https://queue.taskcluster.net/v1/task/b0RIcHGxQVmCDF_P3NNDKg/artifacts/public/build/target.common.tests.zip into memory 17:07:20 INFO - Content-Length response header: 54002001 17:07:20 INFO - Bytes received: 54002001 17:07:31 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 17:07:31 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/b0RIcHGxQVmCDF_P3NNDKg/artifacts/public/build/target.common.tests.zip 17:07:31 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/b0RIcHGxQVmCDF_P3NNDKg/artifacts/public/build/target.common.tests.zip'}, attempt #1 17:07:31 INFO - Fetch https://queue.taskcluster.net/v1/task/b0RIcHGxQVmCDF_P3NNDKg/artifacts/public/build/target.common.tests.zip into memory 17:07:32 INFO - Content-Length response header: 54002001 17:07:32 INFO - Bytes received: 54002001 17:07:44 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/b0RIcHGxQVmCDF_P3NNDKg/artifacts/public/build/target.talos.tests.zip 17:07:44 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/b0RIcHGxQVmCDF_P3NNDKg/artifacts/public/build/target.talos.tests.zip'}, attempt #1 17:07:44 INFO - Fetch https://queue.taskcluster.net/v1/task/b0RIcHGxQVmCDF_P3NNDKg/artifacts/public/build/target.talos.tests.zip into memory 17:07:45 INFO - Content-Length response header: 14496161 17:07:45 INFO - Bytes received: 14496161 17:07:45 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')]} 17:07:45 INFO - trying https://queue.taskcluster.net/v1/task/b0RIcHGxQVmCDF_P3NNDKg/artifacts/public/build/target.tar.bz2 17:07:45 INFO - Downloading https://queue.taskcluster.net/v1/task/b0RIcHGxQVmCDF_P3NNDKg/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 17:07:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/b0RIcHGxQVmCDF_P3NNDKg/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 17:07:46 INFO - Downloaded 62316180 bytes. 17:07:46 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/b0RIcHGxQVmCDF_P3NNDKg/artifacts/public/build/target.tar.bz2 17:07:46 INFO - mkdir: /builds/slave/test/properties 17:07:46 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:07:46 INFO - Writing to file /builds/slave/test/properties/build_url 17:07:46 INFO - Contents: 17:07:46 INFO - build_url:https://queue.taskcluster.net/v1/task/b0RIcHGxQVmCDF_P3NNDKg/artifacts/public/build/target.tar.bz2 17:07:46 INFO - Running post-action listener: _resource_record_post_action 17:07:46 INFO - Running post-action listener: find_tests_for_verification 17:07:46 INFO - Running post-action listener: set_extra_try_arguments 17:07:46 INFO - [mozharness: 2017-08-18 00:07:46.620113Z] Finished download-and-extract step (success) 17:07:46 INFO - [mozharness: 2017-08-18 00:07:46.620209Z] Running populate-webroot step. 17:07:46 INFO - Running pre-action listener: _resource_record_pre_action 17:07:46 INFO - Running main action method: populate_webroot 17:07:46 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:07:46 INFO - 'chromez-stylo-e10s': {'talos_options': ['--stylo'], 17:07:46 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:07:46 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:07:46 INFO - 'dromaeojs-stylo-e10s': {'talos_options': ['--stylo'], 17:07:46 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:07:46 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 17:07:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:07:46 INFO - 'g1-stylo-e10s': {'pagesets_name': 'tp5n.zip', 17:07:46 INFO - 'talos_options': ['--stylo'], 17:07:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:07:46 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 17:07:46 INFO - 'tests': ['damp', 'tps']}, 17:07:46 INFO - 'g2-stylo-e10s': {'pagesets_name': 'tp5n.zip', 17:07:46 INFO - 'talos_options': ['--stylo'], 17:07:46 INFO - 'tests': ['damp', 'tps']}, 17:07:46 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:07:46 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 17:07:46 INFO - 'g4-stylo-e10s': {'talos_options': ['--stylo'], 17:07:46 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 17:07:46 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 17:07:46 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 17:07:46 INFO - 'g5-stylo-e10s': {'pagesets_name': 'tp5n.zip', 17:07:46 INFO - 'talos_options': ['--stylo'], 17:07:46 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 17:07:46 INFO - 'other-e10s': {'tests': ['a11yr', 17:07:46 INFO - 'ts_paint', 17:07:46 INFO - 'tpaint', 17:07:46 INFO - 'sessionrestore', 17:07:46 INFO - 'sessionrestore_many_windows', 17:07:46 INFO - 'sessionrestore_no_auto_restore', 17:07:46 INFO - 'tabpaint']}, 17:07:46 INFO - 'other-stylo-e10s': {'talos_options': ['--stylo'], 17:07:46 INFO - 'tests': ['a11yr', 17:07:46 INFO - 'ts_paint', 17:07:46 INFO - 'tpaint', 17:07:46 INFO - 'sessionrestore', 17:07:46 INFO - 'sessionrestore_many_windows', 17:07:46 INFO - 'sessionrestore_no_auto_restore', 17:07:46 INFO - 'tabpaint']}, 17:07:46 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 17:07:46 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 17:07:46 INFO - 'perf-reftest-singletons-stylo-e10s': {'talos_options': ['--stylo'], 17:07:46 INFO - 'tests': ['bloom_basic_singleton']}, 17:07:46 INFO - 'perf-reftest-stylo-e10s': {'talos_options': ['--stylo'], 17:07:46 INFO - 'tests': ['bloom_basic']}, 17:07:46 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:07:46 INFO - 'tsvgr_opacity', 17:07:46 INFO - 'tart', 17:07:46 INFO - 'tscrollx', 17:07:46 INFO - 'tsvg_static']}, 17:07:46 INFO - 'svgr-stylo-e10s': {'talos_options': ['--stylo'], 17:07:46 INFO - 'tests': ['tsvgx', 17:07:46 INFO - 'tsvgr_opacity', 17:07:46 INFO - 'tart', 17:07:46 INFO - 'tscrollx', 17:07:46 INFO - 'tsvg_static']}, 17:07:46 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 17:07:46 INFO - 'tp5o-stylo-e10s': {'pagesets_name': 'tp5n.zip', 17:07:46 INFO - 'talos_options': ['--stylo'], 17:07:46 INFO - 'tests': ['tp5o']}, 17:07:46 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 17:07:46 INFO - 'talos_options': ['--mitmproxy', 17:07:46 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 17:07:46 INFO - '--firstNonBlankPaint'], 17:07:46 INFO - 'tests': ['tp6_google', 17:07:46 INFO - 'tp6_youtube', 17:07:46 INFO - 'tp6_amazon', 17:07:46 INFO - 'tp6_facebook']}, 17:07:46 INFO - 'tp6-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 17:07:46 INFO - 'talos_options': ['--stylo', 17:07:46 INFO - '--mitmproxy', 17:07:46 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 17:07:46 INFO - '--firstNonBlankPaint'], 17:07:46 INFO - 'tests': ['tp6_google', 17:07:46 INFO - 'tp6_youtube', 17:07:46 INFO - 'tp6_amazon', 17:07:46 INFO - 'tp6_facebook']}, 17:07:46 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 17:07:46 INFO - 'talos_options': ['--stylo', 17:07:46 INFO - '--stylo-threads=1', 17:07:46 INFO - '--mitmproxy', 17:07:46 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 17:07:46 INFO - '--firstNonBlankPaint'], 17:07:46 INFO - 'tests': ['tp6_google', 17:07:46 INFO - 'tp6_youtube', 17:07:46 INFO - 'tp6_amazon', 17:07:46 INFO - 'tp6_facebook']}, 17:07:46 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 17:07:46 INFO - 'talos_options': ['--xperf_path', 17:07:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:07:46 INFO - 'tests': ['tp5n']}, 17:07:46 INFO - 'xperf-stylo-e10s': {'pagesets_name': 'tp5n.zip', 17:07:46 INFO - 'talos_options': ['--stylo', 17:07:46 INFO - '--xperf_path', 17:07:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:07:46 INFO - 'tests': ['tp5n']}}} 17:07:46 INFO - Running post-action listener: _resource_record_post_action 17:07:46 INFO - [mozharness: 2017-08-18 00:07:46.634512Z] Finished populate-webroot step (success) 17:07:46 INFO - [mozharness: 2017-08-18 00:07:46.634600Z] Running create-virtualenv step. 17:07:46 INFO - Running pre-action listener: _resource_record_pre_action 17:07:46 INFO - Running main action method: create_virtualenv 17:07:46 INFO - Creating virtualenv /builds/slave/test/build/venv 17:07:46 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 17:07:46 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:07:46 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 17:07:46 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:07:46 INFO - Using real prefix '/usr' 17:07:46 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:07:47 INFO - Installing distribute.............................................................................................................................................................................................done. 17:07:49 INFO - Installing pip.................done. 17:07:49 INFO - Return code: 0 17:07:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 17:07:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 17:07:49 INFO - Reading from file tmpfile_stdout 17:07:49 INFO - Output received: 17:07:49 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) 17:07:49 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:07:49 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')]} 17:07:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:07:49 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')]} 17:07:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:07:49 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 0xce01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xde6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf89ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf870b0>, '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 0xf87fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf88440>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1503014834.80210-986790238', '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 17:07:49 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 17:07:49 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 17:07:49 INFO - Using env: {'DISPLAY': ':0', 17:07:49 INFO - 'HOME': '/home/cltbld', 17:07:49 INFO - 'LANG': 'en_US.UTF-8', 17:07:49 INFO - 'LANGUAGE': 'en_US:en', 17:07:49 INFO - 'LOGNAME': 'cltbld', 17:07:49 INFO - 'MAIL': '/var/mail/cltbld', 17:07:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:07:49 INFO - 'MOZ_NO_REMOTE': '1', 17:07:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:07:49 INFO - 'NO_EM_RESTART': '1', 17:07:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:07:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:07:49 INFO - 'PWD': '/builds/slave/test', 17:07:49 INFO - 'SHELL': '/bin/bash', 17:07:49 INFO - 'SHLVL': '1', 17:07:49 INFO - 'TERM': 'linux', 17:07:49 INFO - 'TMOUT': '86400', 17:07:49 INFO - 'USER': 'cltbld', 17:07:49 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1503014834.80210-986790238', 17:07:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:07:49 INFO - '_': '/tools/buildbot/bin/python'} 17:07:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:07:49 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 17:07:49 INFO - Cleaning up... 17:07:49 INFO - Return code: 0 17:07:49 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 17:07:49 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')]} 17:07:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:07:49 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')]} 17:07:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:07:49 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 0xce01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xde6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf89ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf870b0>, '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 0xf87fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf88440>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1503014834.80210-986790238', '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 17:07:49 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 17:07:49 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 17:07:49 INFO - Using env: {'DISPLAY': ':0', 17:07:49 INFO - 'HOME': '/home/cltbld', 17:07:49 INFO - 'LANG': 'en_US.UTF-8', 17:07:49 INFO - 'LANGUAGE': 'en_US:en', 17:07:49 INFO - 'LOGNAME': 'cltbld', 17:07:49 INFO - 'MAIL': '/var/mail/cltbld', 17:07:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:07:49 INFO - 'MOZ_NO_REMOTE': '1', 17:07:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:07:49 INFO - 'NO_EM_RESTART': '1', 17:07:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:07:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:07:49 INFO - 'PWD': '/builds/slave/test', 17:07:49 INFO - 'SHELL': '/bin/bash', 17:07:49 INFO - 'SHLVL': '1', 17:07:49 INFO - 'TERM': 'linux', 17:07:49 INFO - 'TMOUT': '86400', 17:07:49 INFO - 'USER': 'cltbld', 17:07:49 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1503014834.80210-986790238', 17:07:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:07:49 INFO - '_': '/tools/buildbot/bin/python'} 17:07:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:07:49 INFO - Downloading/unpacking psutil>=3.1.1 17:07:49 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 17:07:49 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 17:07:49 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 17:07:49 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 17:07:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:07:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:07:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:07:51 INFO - Installing collected packages: psutil 17:07:51 INFO - Running setup.py install for psutil 17:07:51 INFO - building 'psutil._psutil_linux' extension 17:07:51 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 17:07:51 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 17:07:51 INFO - building 'psutil._psutil_posix' extension 17:07:51 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 17:07:51 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 17:07:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:07:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:07:51 INFO - Successfully installed psutil 17:07:51 INFO - Cleaning up... 17:07:51 INFO - Return code: 0 17:07:51 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 17:07:51 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')]} 17:07:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:07:51 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')]} 17:07:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:07:51 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 0xce01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xde6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf89ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf870b0>, '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 0xf87fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf88440>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1503014834.80210-986790238', '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 17:07:51 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 17:07:51 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 17:07:51 INFO - Using env: {'DISPLAY': ':0', 17:07:51 INFO - 'HOME': '/home/cltbld', 17:07:51 INFO - 'LANG': 'en_US.UTF-8', 17:07:51 INFO - 'LANGUAGE': 'en_US:en', 17:07:51 INFO - 'LOGNAME': 'cltbld', 17:07:51 INFO - 'MAIL': '/var/mail/cltbld', 17:07:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:07:51 INFO - 'MOZ_NO_REMOTE': '1', 17:07:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:07:51 INFO - 'NO_EM_RESTART': '1', 17:07:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:07:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:07:51 INFO - 'PWD': '/builds/slave/test', 17:07:51 INFO - 'SHELL': '/bin/bash', 17:07:51 INFO - 'SHLVL': '1', 17:07:51 INFO - 'TERM': 'linux', 17:07:51 INFO - 'TMOUT': '86400', 17:07:51 INFO - 'USER': 'cltbld', 17:07:51 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1503014834.80210-986790238', 17:07:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:07:51 INFO - '_': '/tools/buildbot/bin/python'} 17:07:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:07:51 INFO - Downloading/unpacking mozsystemmonitor==0.3 17:07:51 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 17:07:51 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 17:07:51 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 17:07:51 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 17:07:52 INFO - Downloading mozsystemmonitor-0.3.tar.gz 17:07:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:07:53 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 17:07:53 INFO - Installing collected packages: mozsystemmonitor 17:07:53 INFO - Running setup.py install for mozsystemmonitor 17:07:53 INFO - Successfully installed mozsystemmonitor 17:07:53 INFO - Cleaning up... 17:07:53 INFO - Return code: 0 17:07:53 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 17:07:53 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')]} 17:07:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:07:53 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')]} 17:07:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:07:53 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 0xce01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xde6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf89ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf870b0>, '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 0xf87fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf88440>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1503014834.80210-986790238', '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 17:07:53 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 17:07:53 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 17:07:53 INFO - Using env: {'DISPLAY': ':0', 17:07:53 INFO - 'HOME': '/home/cltbld', 17:07:53 INFO - 'LANG': 'en_US.UTF-8', 17:07:53 INFO - 'LANGUAGE': 'en_US:en', 17:07:53 INFO - 'LOGNAME': 'cltbld', 17:07:53 INFO - 'MAIL': '/var/mail/cltbld', 17:07:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:07:53 INFO - 'MOZ_NO_REMOTE': '1', 17:07:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:07:53 INFO - 'NO_EM_RESTART': '1', 17:07:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:07:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:07:53 INFO - 'PWD': '/builds/slave/test', 17:07:53 INFO - 'SHELL': '/bin/bash', 17:07:53 INFO - 'SHLVL': '1', 17:07:53 INFO - 'TERM': 'linux', 17:07:53 INFO - 'TMOUT': '86400', 17:07:53 INFO - 'USER': 'cltbld', 17:07:53 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1503014834.80210-986790238', 17:07:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:07:53 INFO - '_': '/tools/buildbot/bin/python'} 17:07:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:07:53 INFO - Downloading/unpacking jsonschema==2.5.1 17:07:53 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 17:07:53 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 17:07:53 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 17:07:53 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 17:07:54 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:07:54 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 17:07:54 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 17:07:54 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 17:07:54 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 17:07:54 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 17:07:54 INFO - Downloading functools32-3.2.3-2.tar.gz 17:07:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:07:54 INFO - warning: no files found matching '*.txt' 17:07:54 INFO - no previously-included directories found matching 'build' 17:07:54 INFO - no previously-included directories found matching 'dist' 17:07:54 INFO - no previously-included directories found matching '.git*' 17:07:54 INFO - Installing collected packages: jsonschema, functools32 17:07:54 INFO - Running setup.py install for functools32 17:07:54 INFO - warning: no files found matching '*.txt' 17:07:54 INFO - no previously-included directories found matching 'build' 17:07:54 INFO - no previously-included directories found matching 'dist' 17:07:54 INFO - no previously-included directories found matching '.git*' 17:07:54 INFO - Successfully installed jsonschema functools32 17:07:54 INFO - Cleaning up... 17:07:54 INFO - Return code: 0 17:07:54 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 17:07:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:07:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:07:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:07:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:07:54 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 0xce01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xde6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf89ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf870b0>, '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 0xf87fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf88440>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1503014834.80210-986790238', '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 17:07:54 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 17:07:54 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 17:07:54 INFO - Using env: {'DISPLAY': ':0', 17:07:54 INFO - 'HOME': '/home/cltbld', 17:07:54 INFO - 'LANG': 'en_US.UTF-8', 17:07:54 INFO - 'LANGUAGE': 'en_US:en', 17:07:54 INFO - 'LOGNAME': 'cltbld', 17:07:54 INFO - 'MAIL': '/var/mail/cltbld', 17:07:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:07:54 INFO - 'MOZ_NO_REMOTE': '1', 17:07:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:07:54 INFO - 'NO_EM_RESTART': '1', 17:07:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:07:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:07:54 INFO - 'PWD': '/builds/slave/test', 17:07:54 INFO - 'SHELL': '/bin/bash', 17:07:54 INFO - 'SHLVL': '1', 17:07:54 INFO - 'TERM': 'linux', 17:07:54 INFO - 'TMOUT': '86400', 17:07:54 INFO - 'USER': 'cltbld', 17:07:54 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1503014834.80210-986790238', 17:07:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:07:54 INFO - '_': '/tools/buildbot/bin/python'} 17:07:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:07:55 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 17:07:55 INFO - Cleaning up... 17:07:55 INFO - Return code: 0 17:07:55 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:07:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:07:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:07:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:07:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:07:55 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 0xce01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xde6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf89ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf870b0>, '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 0xf87fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf88440>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1503014834.80210-986790238', '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 17:07:55 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 17:07:55 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 17:07:55 INFO - Using env: {'DISPLAY': ':0', 17:07:55 INFO - 'HOME': '/home/cltbld', 17:07:55 INFO - 'LANG': 'en_US.UTF-8', 17:07:55 INFO - 'LANGUAGE': 'en_US:en', 17:07:55 INFO - 'LOGNAME': 'cltbld', 17:07:55 INFO - 'MAIL': '/var/mail/cltbld', 17:07:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:07:55 INFO - 'MOZ_NO_REMOTE': '1', 17:07:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:07:55 INFO - 'NO_EM_RESTART': '1', 17:07:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:07:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:07:55 INFO - 'PWD': '/builds/slave/test', 17:07:55 INFO - 'SHELL': '/bin/bash', 17:07:55 INFO - 'SHLVL': '1', 17:07:55 INFO - 'TERM': 'linux', 17:07:55 INFO - 'TMOUT': '86400', 17:07:55 INFO - 'USER': 'cltbld', 17:07:55 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1503014834.80210-986790238', 17:07:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:07:55 INFO - '_': '/tools/buildbot/bin/python'} 17:07:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:07:55 INFO - Downloading/unpacking blobuploader==1.2.4 17:07:55 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 17:07:55 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 17:07:55 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 17:07:55 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 17:07:56 INFO - Downloading blobuploader-1.2.4.tar.gz 17:07:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:07:56 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:07:56 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 17:07:56 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 17:07:56 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 17:07:56 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 17:07:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:07:56 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:07:56 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 17:07:56 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 17:07:56 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 17:07:56 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 17:07:56 INFO - Downloading docopt-0.6.1.tar.gz 17:07:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:07:57 INFO - Installing collected packages: blobuploader, requests, docopt 17:07:57 INFO - Running setup.py install for blobuploader 17:07:57 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:07:57 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:07:57 INFO - Running setup.py install for requests 17:07:57 INFO - Running setup.py install for docopt 17:07:57 INFO - Successfully installed blobuploader requests docopt 17:07:57 INFO - Cleaning up... 17:07:57 INFO - Return code: 0 17:07:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:07:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:07:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:07:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:07:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:07:57 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 0xce01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xde6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf89ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf870b0>, '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 0xf87fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf88440>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1503014834.80210-986790238', '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 17:07:57 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 17:07:57 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 17:07:57 INFO - Using env: {'DISPLAY': ':0', 17:07:57 INFO - 'HOME': '/home/cltbld', 17:07:57 INFO - 'LANG': 'en_US.UTF-8', 17:07:57 INFO - 'LANGUAGE': 'en_US:en', 17:07:57 INFO - 'LOGNAME': 'cltbld', 17:07:57 INFO - 'MAIL': '/var/mail/cltbld', 17:07:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:07:57 INFO - 'MOZ_NO_REMOTE': '1', 17:07:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:07:57 INFO - 'NO_EM_RESTART': '1', 17:07:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:07:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:07:57 INFO - 'PWD': '/builds/slave/test', 17:07:57 INFO - 'SHELL': '/bin/bash', 17:07:57 INFO - 'SHLVL': '1', 17:07:57 INFO - 'TERM': 'linux', 17:07:57 INFO - 'TMOUT': '86400', 17:07:57 INFO - 'USER': 'cltbld', 17:07:57 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1503014834.80210-986790238', 17:07:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:07:57 INFO - '_': '/tools/buildbot/bin/python'} 17:07:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:07:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:07:57 INFO - Running setup.py (path:/tmp/pip-bNEd53-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:07:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:07:57 INFO - Running setup.py (path:/tmp/pip-EXVOsJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:07:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:07:58 INFO - Running setup.py (path:/tmp/pip-CkV5cX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:07:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:07:58 INFO - Running setup.py (path:/tmp/pip-Xkwbhe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:07:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:07:58 INFO - Running setup.py (path:/tmp/pip-SmC0cT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:07:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:07:58 INFO - Running setup.py (path:/tmp/pip-PFvQ0L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:07:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:07:58 INFO - Running setup.py (path:/tmp/pip-fXcwXW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:07:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:07:58 INFO - Running setup.py (path:/tmp/pip-3suJTx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:07:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:07:58 INFO - Running setup.py (path:/tmp/pip-Lz6uyN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:07:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:07:58 INFO - Running setup.py (path:/tmp/pip-SWx8Hg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:07:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:07:58 INFO - Running setup.py (path:/tmp/pip-yu3r9_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:07:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:07:58 INFO - Running setup.py (path:/tmp/pip-C0Jcqw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:07:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:07:58 INFO - Running setup.py (path:/tmp/pip-_yVI3W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:07:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:07:58 INFO - Running setup.py (path:/tmp/pip-_zxIU0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:07:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:07:58 INFO - Running setup.py (path:/tmp/pip-YCeQh7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:07:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:07:58 INFO - Running setup.py (path:/tmp/pip-xmKBai-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:07:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:07:59 INFO - Running setup.py (path:/tmp/pip-iKEVa2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:07:59 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:07:59 INFO - Running setup.py install for manifestparser 17:07:59 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:07:59 INFO - Running setup.py install for mozcrash 17:07:59 INFO - Running setup.py install for mozdebug 17:07:59 INFO - Running setup.py install for mozdevice 17:07:59 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:07:59 INFO - Running setup.py install for mozfile 17:07:59 INFO - Running setup.py install for mozhttpd 17:07:59 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:07:59 INFO - Running setup.py install for mozinfo 17:07:59 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:07:59 INFO - Running setup.py install for mozInstall 17:07:59 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:07:59 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:07:59 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:07:59 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:07:59 INFO - Running setup.py install for mozleak 17:07:59 INFO - Running setup.py install for mozlog 17:08:00 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:08:00 INFO - Running setup.py install for moznetwork 17:08:00 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:08:00 INFO - Running setup.py install for mozprocess 17:08:00 INFO - Running setup.py install for mozprofile 17:08:00 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:08:00 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:08:00 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:08:00 INFO - Running setup.py install for mozrunner 17:08:00 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:08:00 INFO - Running setup.py install for mozscreenshot 17:08:00 INFO - Running setup.py install for moztest 17:08:00 INFO - Running setup.py install for mozversion 17:08:00 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:08:00 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:08:00 INFO - Cleaning up... 17:08:00 INFO - Return code: 0 17:08:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:08:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:08:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:08:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:08:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:08:00 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 0xce01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xde6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf89ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf870b0>, '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 0xf87fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf88440>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1503014834.80210-986790238', '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 17:08:00 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 17:08:00 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 17:08:00 INFO - Using env: {'DISPLAY': ':0', 17:08:00 INFO - 'HOME': '/home/cltbld', 17:08:00 INFO - 'LANG': 'en_US.UTF-8', 17:08:00 INFO - 'LANGUAGE': 'en_US:en', 17:08:00 INFO - 'LOGNAME': 'cltbld', 17:08:00 INFO - 'MAIL': '/var/mail/cltbld', 17:08:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:08:00 INFO - 'MOZ_NO_REMOTE': '1', 17:08:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:08:00 INFO - 'NO_EM_RESTART': '1', 17:08:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:08:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:08:00 INFO - 'PWD': '/builds/slave/test', 17:08:00 INFO - 'SHELL': '/bin/bash', 17:08:00 INFO - 'SHLVL': '1', 17:08:00 INFO - 'TERM': 'linux', 17:08:00 INFO - 'TMOUT': '86400', 17:08:00 INFO - 'USER': 'cltbld', 17:08:00 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1503014834.80210-986790238', 17:08:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:08:00 INFO - '_': '/tools/buildbot/bin/python'} 17:08:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:08:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:08:01 INFO - Running setup.py (path:/tmp/pip-gbxOl4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:08:01 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)) 17:08:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:08:01 INFO - Running setup.py (path:/tmp/pip-h2sPFu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:08:01 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)) 17:08:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:08:01 INFO - Running setup.py (path:/tmp/pip-7mUQhf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:08:01 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)) 17:08:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:08:01 INFO - Running setup.py (path:/tmp/pip-hKvfKi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:08:01 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)) 17:08:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:08:01 INFO - Running setup.py (path:/tmp/pip-9L0pde-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:08:01 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)) 17:08:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:08:01 INFO - Running setup.py (path:/tmp/pip-mPR9_B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:08:01 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)) 17:08:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:08:01 INFO - Running setup.py (path:/tmp/pip-cAnh1X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:08:01 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)) 17:08:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:08:01 INFO - Running setup.py (path:/tmp/pip-kNuVZk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:08:01 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)) 17:08:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:08:01 INFO - Running setup.py (path:/tmp/pip-QXlho4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:08:01 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)) 17:08:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:08:01 INFO - Running setup.py (path:/tmp/pip-EHKN6v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:08:01 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)) 17:08:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:08:01 INFO - Running setup.py (path:/tmp/pip-uGJQez-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:08:01 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)) 17:08:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:08:01 INFO - Running setup.py (path:/tmp/pip-dzKXEO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:08:02 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)) 17:08:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:08:02 INFO - Running setup.py (path:/tmp/pip-VePJb0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:08:02 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)) 17:08:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:08:02 INFO - Running setup.py (path:/tmp/pip-hn5fQl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:08:02 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)) 17:08:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:08:02 INFO - Running setup.py (path:/tmp/pip-oEZC7J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:08:02 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)) 17:08:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:08:02 INFO - Running setup.py (path:/tmp/pip-M16dWE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:08:02 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)) 17:08:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:08:02 INFO - Running setup.py (path:/tmp/pip-c3kc47-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:08:02 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)) 17:08:02 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)) 17:08:02 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)) 17:08:02 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)) 17:08:02 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)) 17:08:02 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)) 17:08:02 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)) 17:08:02 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:08:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:08:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:08:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:08:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:08:03 INFO - Downloading blessings-1.6.tar.gz 17:08:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:08:03 INFO - Installing collected packages: blessings 17:08:03 INFO - Running setup.py install for blessings 17:08:03 INFO - Successfully installed blessings 17:08:03 INFO - Cleaning up... 17:08:03 INFO - Return code: 0 17:08:03 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:08:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:08:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:08:03 INFO - Reading from file tmpfile_stdout 17:08:03 INFO - Current package versions: 17:08:03 INFO - argparse == 1.2.1 17:08:03 INFO - blessings == 1.6 17:08:03 INFO - blobuploader == 1.2.4 17:08:03 INFO - docopt == 0.6.1 17:08:03 INFO - functools32 == 3.2.3-2 17:08:03 INFO - jsonschema == 2.5.1 17:08:03 INFO - manifestparser == 1.1 17:08:03 INFO - mozInstall == 1.13 17:08:03 INFO - mozcrash == 1.0 17:08:03 INFO - mozdebug == 0.1 17:08:03 INFO - mozdevice == 0.51 17:08:03 INFO - mozfile == 1.2 17:08:03 INFO - mozhttpd == 0.7 17:08:03 INFO - mozinfo == 0.10 17:08:03 INFO - mozleak == 0.1 17:08:03 INFO - mozlog == 3.5 17:08:03 INFO - moznetwork == 0.27 17:08:03 INFO - mozprocess == 0.25 17:08:03 INFO - mozprofile == 0.28 17:08:03 INFO - mozrunner == 6.13 17:08:03 INFO - mozscreenshot == 0.1 17:08:03 INFO - mozsystemmonitor == 0.3 17:08:03 INFO - moztest == 0.8 17:08:03 INFO - mozversion == 1.4 17:08:03 INFO - psutil == 3.1.1 17:08:03 INFO - requests == 1.2.3 17:08:03 INFO - wsgiref == 0.1.2 17:08:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:08:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:08:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:08:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:08:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:08:03 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 0xce01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xde6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf89ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf870b0>, '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 0xf87fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf88440>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1503014834.80210-986790238', '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 17:08:03 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 17:08:03 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 17:08:03 INFO - Using env: {'DISPLAY': ':0', 17:08:03 INFO - 'HOME': '/home/cltbld', 17:08:03 INFO - 'LANG': 'en_US.UTF-8', 17:08:03 INFO - 'LANGUAGE': 'en_US:en', 17:08:03 INFO - 'LOGNAME': 'cltbld', 17:08:03 INFO - 'MAIL': '/var/mail/cltbld', 17:08:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:08:03 INFO - 'MOZ_NO_REMOTE': '1', 17:08:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:08:03 INFO - 'NO_EM_RESTART': '1', 17:08:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:08:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:08:03 INFO - 'PWD': '/builds/slave/test', 17:08:03 INFO - 'SHELL': '/bin/bash', 17:08:03 INFO - 'SHLVL': '1', 17:08:03 INFO - 'TERM': 'linux', 17:08:03 INFO - 'TMOUT': '86400', 17:08:03 INFO - 'USER': 'cltbld', 17:08:03 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1503014834.80210-986790238', 17:08:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:08:03 INFO - '_': '/tools/buildbot/bin/python'} 17:08:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:08:04 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)) 17:08:04 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)) 17:08:04 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)) 17:08:04 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)) 17:08:04 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)) 17:08:04 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)) 17:08:04 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)) 17:08:04 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)) 17:08:04 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)) 17:08:04 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 17:08:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:08:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:08:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:08:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:08:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 17:08:05 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)) 17:08:05 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)) 17:08:05 INFO - Installing collected packages: simplejson 17:08:05 INFO - Running setup.py install for simplejson 17:08:05 INFO - building 'simplejson._speedups' extension 17:08:05 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 17:08:06 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 17:08:06 INFO - Successfully installed simplejson 17:08:06 INFO - Cleaning up... 17:08:06 INFO - Return code: 0 17:08:06 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:08:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:08:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:08:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:08:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:08:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xce01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xde6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf89ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf870b0>, '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 0xf87fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf88440>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1503014834.80210-986790238', '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 17:08:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 17:08:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 17:08:06 INFO - Using env: {'DISPLAY': ':0', 17:08:06 INFO - 'HOME': '/home/cltbld', 17:08:06 INFO - 'LANG': 'en_US.UTF-8', 17:08:06 INFO - 'LANGUAGE': 'en_US:en', 17:08:06 INFO - 'LOGNAME': 'cltbld', 17:08:06 INFO - 'MAIL': '/var/mail/cltbld', 17:08:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:08:06 INFO - 'MOZ_NO_REMOTE': '1', 17:08:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:08:06 INFO - 'NO_EM_RESTART': '1', 17:08:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:08:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:08:06 INFO - 'PWD': '/builds/slave/test', 17:08:06 INFO - 'SHELL': '/bin/bash', 17:08:06 INFO - 'SHLVL': '1', 17:08:06 INFO - 'TERM': 'linux', 17:08:06 INFO - 'TMOUT': '86400', 17:08:06 INFO - 'USER': 'cltbld', 17:08:06 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1503014834.80210-986790238', 17:08:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:08:06 INFO - '_': '/tools/buildbot/bin/python'} 17:08:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:08:06 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 17:08:06 INFO - Cleaning up... 17:08:06 INFO - Return code: 0 17:08:06 INFO - Running post-action listener: _resource_record_post_action 17:08:06 INFO - Running post-action listener: _start_resource_monitoring 17:08:06 INFO - Starting resource monitoring. 17:08:06 INFO - [mozharness: 2017-08-18 00:08:06.699619Z] Finished create-virtualenv step (success) 17:08:06 INFO - [mozharness: 2017-08-18 00:08:06.700209Z] Running install step. 17:08:06 INFO - Running pre-action listener: _resource_record_pre_action 17:08:06 INFO - Running main action method: install 17:08:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:08:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:08:06 INFO - Reading from file tmpfile_stdout 17:08:06 INFO - Detecting whether we're running mozinstall >=1.0... 17:08:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:08:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:08:07 INFO - Reading from file tmpfile_stdout 17:08:07 INFO - Output received: 17:08:07 INFO - Usage: mozinstall [options] installer 17:08:07 INFO - Options: 17:08:07 INFO - -h, --help show this help message and exit 17:08:07 INFO - -d DEST, --destination=DEST 17:08:07 INFO - Directory to install application into. [default: 17:08:07 INFO - "/builds/slave/test"] 17:08:07 INFO - --app=APP Application being installed. [default: firefox] 17:08:07 INFO - mkdir: /builds/slave/test/build/application 17:08:07 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'] 17:08:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 17:08:25 INFO - Reading from file tmpfile_stdout 17:08:25 INFO - Output received: 17:08:25 INFO - /builds/slave/test/build/application/firefox/firefox 17:08:25 INFO - Running post-action listener: _resource_record_post_action 17:08:25 INFO - [mozharness: 2017-08-18 00:08:25.313566Z] Finished install step (success) 17:08:25 INFO - [mozharness: 2017-08-18 00:08:25.313845Z] Running setup-mitmproxy step. 17:08:25 INFO - Running pre-action listener: _resource_record_pre_action 17:08:25 INFO - Running main action method: setup_mitmproxy 17:08:25 INFO - Skipping: mitmproxy is not required 17:08:25 INFO - Running post-action listener: _resource_record_post_action 17:08:25 INFO - [mozharness: 2017-08-18 00:08:25.314971Z] Finished setup-mitmproxy step (success) 17:08:25 INFO - [mozharness: 2017-08-18 00:08:25.315186Z] Running run-tests step. 17:08:25 INFO - Running pre-action listener: _resource_record_pre_action 17:08:25 INFO - Running pre-action listener: _set_gcov_prefix 17:08:25 INFO - Running main action method: run_tests 17:08:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:08:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:08:25 INFO - Python 2.7.3 17:08:25 INFO - Return code: 0 17:08:25 INFO - grabbing minidump binary from tooltool 17:08: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')]} 17:08:25 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 0xf870b0>, '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 0xf87fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf88440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:08:25 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 17:08:25 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 17:08:25 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 17:08:25 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:08:25 INFO - Return code: 0 17:08:25 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 17:08:25 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:08:25 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:08:25 INFO - ENV: RUST_BACKTRACE is now full 17:08:25 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 17:08:25 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:08:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/b0RIcHGxQVmCDF_P3NNDKg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-062', '--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 17:08:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/b0RIcHGxQVmCDF_P3NNDKg/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-062 --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 17:08:25 INFO - Using env: {'DISPLAY': ':0', 17:08:25 INFO - 'HOME': '/home/cltbld', 17:08:25 INFO - 'LANG': 'en_US.UTF-8', 17:08:25 INFO - 'LANGUAGE': 'en_US:en', 17:08:25 INFO - 'LOGNAME': 'cltbld', 17:08:25 INFO - 'MAIL': '/var/mail/cltbld', 17:08:25 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:08:25 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:08:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:08:25 INFO - 'MOZ_NO_REMOTE': '1', 17:08:25 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:08:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:08:25 INFO - 'NO_EM_RESTART': '1', 17:08:25 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:08:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:08:25 INFO - 'PWD': '/builds/slave/test', 17:08:25 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:08:25 INFO - 'RUST_BACKTRACE': 'full', 17:08:25 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 17:08:25 INFO - 'SHELL': '/bin/bash', 17:08:25 INFO - 'SHLVL': '1', 17:08:25 INFO - 'TERM': 'linux', 17:08:25 INFO - 'TMOUT': '86400', 17:08:25 INFO - 'USER': 'cltbld', 17:08:25 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1503014834.80210-986790238', 17:08:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:08:25 INFO - '_': '/tools/buildbot/bin/python'} 17:08:25 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/b0RIcHGxQVmCDF_P3NNDKg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-062', '--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 17:08:25 INFO - mozversion application_buildid: 20170817231714 17:08:25 INFO - mozversion application_changeset: a6a1f5c1d971dbee67ba6eec7ead7902351ddca2 17:08:25 INFO - mozversion application_display_name: Nightly 17:08:25 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:08:25 INFO - mozversion application_name: Firefox 17:08:25 INFO - mozversion application_remotingname: firefox 17:08:25 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 17:08:25 INFO - mozversion application_vendor: Mozilla 17:08:25 INFO - mozversion application_version: 57.0a1 17:08:25 INFO - mozversion platform_buildid: 20170817231714 17:08:25 INFO - mozversion platform_changeset: a6a1f5c1d971dbee67ba6eec7ead7902351ddca2 17:08:25 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 17:08:25 INFO - mozversion platform_version: 57.0a1 17:08:25 INFO - using testdate: 1503014905 17:08:25 INFO - actual date: 1503014905 17:08:25 INFO - starting webserver on 'localhost:54689' 17:08:25 INFO - SUITE-START | Running 2 tests 17:08:25 INFO - TEST-START | dromaeo_css 17:08:25 INFO - Initialising browser for dromaeo_css test... 17:08:25 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:54689/getInfo.html -profile /tmp/tmpNGaMN8/profile 17:08:25 INFO - TEST-INFO | started process 12245 (/builds/slave/test/build/application/firefox/firefox http://localhost:54689/getInfo.html) 17:08:31 INFO - TEST-INFO | 12245: exit 0 17:08:31 INFO - Browser initialized. 17:08:31 INFO - Running cycle 1/1 for dromaeo_css test... 17:08:31 INFO - TEST-INFO | started process 12420 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNGaMN8/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 17:08:32 INFO - PID 12420 | 17:08:32 INFO - PID 12420 | (/builds/slave/test/build/application/firefox/firefox:12467): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 17:08:32 INFO - PID 12420 | 17:08:42 INFO - PID 12420 | RSS: Main: 163897344 17:08:42 INFO - PID 12420 | 17:11:41 INFO - PID 12420 | Cycle 1(1): loaded http://localhost:54689/tests/dromaeo/cssquery-dojo.html (next: http://localhost:54689/tests/dromaeo/cssquery-ext.html) 17:11:42 INFO - PID 12420 | RSS: Main: 171438080 17:11:42 INFO - PID 12420 | 17:14:44 INFO - PID 12420 | Cycle 1(1): loaded http://localhost:54689/tests/dromaeo/cssquery-ext.html (next: http://localhost:54689/tests/dromaeo/cssquery-jquery.html) 17:14:45 INFO - PID 12420 | RSS: Main: 168185856 17:14:45 INFO - PID 12420 | 17:17:46 INFO - PID 12420 | Cycle 1(1): loaded http://localhost:54689/tests/dromaeo/cssquery-jquery.html (next: http://localhost:54689/tests/dromaeo/cssquery-mootools.html) 17:17:47 INFO - PID 12420 | RSS: Main: 171020288 17:17:47 INFO - PID 12420 | 17:20:49 INFO - PID 12420 | Cycle 1(1): loaded http://localhost:54689/tests/dromaeo/cssquery-mootools.html (next: http://localhost:54689/tests/dromaeo/cssquery-prototype.html) 17:20:50 INFO - PID 12420 | RSS: Main: 169254912 17:20:50 INFO - PID 12420 | 17:23:53 INFO - PID 12420 | Cycle 1(1): loaded http://localhost:54689/tests/dromaeo/cssquery-prototype.html (next: http://localhost:54689/tests/dromaeo/cssquery-yui.html) 17:23:54 INFO - PID 12420 | RSS: Main: 173121536 17:23:54 INFO - PID 12420 | 17:26:55 INFO - PID 12420 | Cycle 1(1): loaded http://localhost:54689/tests/dromaeo/cssquery-yui.html (next: http://localhost:54689/tests/dromaeo/cssquery-dojo.html) 17:26:56 INFO - PID 12420 | RSS: Main: 173707264 17:26:56 INFO - PID 12420 | 17:26:56 INFO - PID 12420 | __start_tp_report 17:26:56 INFO - PID 12420 | _x_x_mozilla_page_load 17:26:56 INFO - PID 12420 | _x_x_mozilla_page_load_details 17:26:56 INFO - PID 12420 | |i|pagename|runs| 17:26:56 INFO - PID 12420 | |0;dojo.html;3137.137287246007;3153.558501809747;3178.3961047400994;3206.7434605231583;3211.020638705194;6231.408016238462;6283.120363149163;6297.3702629737;6354.205724284465;6380.872382552347;6073.9392606073925;6157.7536898524;6159.168512250856;6171.9382806171925;6181.918164321237;5670.177824215507;5684.317881854184;5719.485246327829;5721.713914304289;5727.026405511052;5772.595918285721;5785.074388097905;5808.59339846211;5815;5869.530437564985;5711.628744131618;5761.510271626917;5787.681677507735;5814.970925145369;5860.355360910296;5537.889242215173;5598.188262701926;5635.520980716644;5684.886302273972;5774.538036957033;5565;5580.218769372291;5654.321481422215;5659.292588426447;5673.063944449161;5978.073398623221;6044.395560443921;6101.237345331833;6102.176206212149;6164.907526387108;6565.343465653396;6576.704048317837;6600.603963762142;6607.273199948002;6612.801615951529;6655.833604159886;6670.199576050856;6672.733090676367;6673.699683514254;6681.331866813329;6150.569460137792;6165.32181460039;6172.382761723837;6234.314225435199;6255.343188965184;6876.759313424006;6920.204176519765;6956.930430695729;6982.092327997328;7006;6512.348765123545;6534.379233972765;6564.310747371553;6630.734770609218;6654.73381064752;6547.9672601636685;6652.135222421054;6687.966560167168;6727.865442691119;6734.595924244561;6557.245916719638;6570.540062195696;6583.9136542470915;6609.173853268341;6648.66756662165;6678.632675202911;6694.297098804653;6700.564463309869;6722.462203023746;6729.327067293231;5386.057439948072;5457.508824205841;5461.590380721383;5465.043617366945;5480.835574932758;4508.165989291926;4566.794494247767;4592.609628181575;4603.539646035437;4613.192691279013;5651.265335506358;5672.12082127271;5748.626339287933;5755.798547050833;5762.049261871828;6724.731010759515;6731.697073631698;6733.696983635748;6754.45964322853;6758.560693554903;5687.488126068673;5769.451902069297;5778.88442231153;5826.912596311059;5842.269716285465;5749.022666146765;5835.270591176103;5858.209141765892;5883.529317654577;5929.3181284152015;6418.871622567616;6429;6435.581687190318;6435.613863168225;6438.871222575616;6543.869122617616;6628.237752658506;6640.634765087966;6644.368784965421;6740.090087838079;6449.742300251406;6458.741650333934;6458.903116453163;6469.611823290617;6470.773522926864;6506.642134682638;6539.771108011387;6541.738330466918;6562.179727534059;6608.867822643617;6608.735650574115;6709.261981181969;6711.228208756055;6772.390484856386;6792.796216113525;6355.936440635719;6391.3289104643345;6398.1362516059735;6398.488120950406;6446.774362897276;6371.681415929278;6375.6174629522375;6385.393387628168;6387.552871298964;6388.456981156468;6086.147939288415;6324.114623952558;6339.461145802658;6452.774152904626;6456.386643268882;6513.446357059703;6574.868502630016;6613.801585952429;6641.734330626914;6684.4652427804685;6159.722812473539;6308.211473565804;6341.429271365415;6385.233771947396;6457.354264573693 17:26:56 INFO - PID 12420 | |1;ext.html;816.9550674712889;834.2783492279173;851.4423052900349;868.3227082875358;873.1617647058823;43062.56937430625;43193.35209971849;43523.56476435235;43560.56439435605;43598.782006090005;38729.41905871414;38798;38931.41602875959;39256.21487570247;39351.21297574047;6945.374916257536;7075.85848283034;7086.255943125975;7103.25415831338;7107.928920710804;6980.825479363031;6981.581105133709;7054.823629409255;7060.188078371002;7064.858702825941;7722.1119571249465;7776.416768742339;7785.260400261966;7858.096318923312;7891.329237014861;7676.385889128856;7753.844923101535;7754.689812407497;7769.8057548561455;7847.5291482510665;7631.694732210705;7647.808804779925;7702.768916932501;7789.337906277973;7895.407844411692;39336.21327573433;39759.80120099381;39784.40323395151;39813.20373592541;39942.400863987066;3563.322968635977;3578.6421357864265;3586.7130629549574;3589.407747721623;3595.676389124965;31272.843635781675;31469;31588;31882.840585796923;32116.197095072577;5084.949150508522;5113.872153196163;5134.512221339004;5145.228215767665;5161.664491808058;188113;188161;189522;190884;190937;51638.74180629073;51722.224166637534;51784;51784.74107629438;51920.74039629778;52453.213201802006;52498.73750631299;52506.47493525016;52521.212181817304;52681.2097818533;16544.42094526686;16762.664746705;16784.916075419544;16813.91593042027;16816.83183168177;13689.31553422325;13754;13754.243516606482;13767.449302028008;13778;14748.92625536887;14915.552533424014;15069.17119558413;15070.849291507164;15187.240637968278;5902.8819423611285;5926.436988486087;5949.583529153005;5965.910511342333;6108.938910610926;978.4229889629142;1005.627917670452;1009.3388830316155;1015.4973288222229;1021.0759262867117;22130.557388852132;22780.658290125662;22786.316410507712;22845.543089138126;22859.085636574684;1108.0692218536308;1110.4059328259343;1118.189312748251;1121.2879821313525;1129.5312445335094;12029.278243305429;12187.568679946406;12233.694157645952;16344.264508097163;16580.83419165817;223782;226027;227105;227379;227611;58541.70729146327;59273;59790.70104649536;59945.40054599485;60109.39890601126;1487.6950225203807;1509.6527798606382;1520.9619759506102;1521.193767303331;1530.2425299476608;27649.447011060067;27693.169204923885;27720.445591088468;27731.336119832875;27805.721942780314;53161.202581960526;53212.73393633007;53562.46437535575;53602.731986339815;53944;200937;201228;201926;202164;202407;35832.820835895654;36251.45622815713;36365.454518181716;36664.81667591645;36750.26499470049;44288.77855610701;45608.31587526256;46698.29952550647;46859.53140468552;46867.53132468768;32810.50784238191;32956;33124.50313245255;33131.668683312855;33446.99659010234;32643;33365.332693346485;33419;33802;34159.829200853834;35959.28081438304;36005.45991810073;36040.4593931086;36152.819235903655;36293;32376.83811580927;32463.513047303837;32837.50743738894;33116.503252451716;33415;22897;24034.158804441762;24326.391840204138;25269.87365063163;25486.745132548436 17:26:56 INFO - PID 12420 | |2;jquery.html;569.8375962850588;576.2336092996316;590.9763609455622;593.1044123373706;601.1133577972491;22912.083516659335;23755.76244237557;23809.40476488089;23851;23906.641400378965;24787.380315492122;27023.189304320902;27060.729392706115;27097.593536096974;27191.184264472096;6640.667966601674;6694.564853284545;6746.359095885908;6761.985702144693;6775.119234499508;5960.672163031031;6547.57440766351;6683.799486015428;6763.966180169093;6766.763163289286;6451.612903225821;6452.193475815523;6456.612603243821;6466.35336466352;6467.191601049869;6472.255690595594;6489.123968264318;6500.8699826003685;6502.382273683992;6517.152770139875;6023.488003519706;6056.636601803906;6063.272407311151;6069.211002569682;6084.574079814415;29355.11934641964;29442.70557294421;29912.401751965055;30233;30604.693953060407;1905.9523511912175;1951.4535929939639;1953.7069439584034;1957.4812674641232;1963.4894927319;19486.220551177936;19830.603387932162;20194.39416817498;20968.266110686054;21009.159633614636;2389.342930694073;2410.14439873844;2412.16780210827;2418.73112675433;2475.3687809608437;140142;142561.72314830573;142759.28620356935;143103.28448357797;143655.2817235928;14143.22212278314;14693.7224730167;15009.474668386554;15464.381424742884;15521.758259339225;23252.65121023186;23281.534369312856;23292;23386.532269354517;23395.883020584788;10281.845772313422;10438.269321147447;10503.737406564896;10511.84232236517;10563.154947604173;9750.171235445066;9862.733615872492;9901.653442129491;9908.108270255712;9966.302358834811;8918.1973622373;9200.35597508168;9310.767230819149;9346.299027572959;9646.758831029281;2802.4114935863695;2820.464111818748;2872.540393537024;2900.608417863604;2954.290970167144;945.2674177512483;961.6345788600287;979.8726165598426;982.7002764156858;999.5551979369257;19367.225310987684;24138.51722965531;24962.37594060163;25143.87428062848;25191.62212566813;1004.5228516454625;1047.4448542272607;1054.926155169146;1068.076114161245;1071.4482041748506;10665.040146386862;10819.242653014371;10893.455327233607;10902.836457453144;11007.06439952613;480331;495782;497472;499716;502843;120339.39830300793;121873;123685.38157309336;124460.37769811274;126384;1280.603013065934;1292.4507084489055;1302.179626835088;1307.4639397846838;1319.12937461277;17359.652806943537;17612.82387176163;17806;17833.10834458298;17953.73069403934;53045.4695453056;53354.46645533495;53768.462315376346;54060;55319.44680553143;69900.30099698938;69991.65004174947;73713;73929.26070739224;75888.62055689686;14362.497312594009;14513.492027778977;14580.489682861049;14656.193909334663;14689.118652880861;23165.652515212623;23344.6498302529;23430.76569234354;23440.64839027382;23821.642675359537;18274.90862545679;18746.906265468584;18841;18870.3395381161;18931.90534047321;16755.1622418881;16910.746338805173;17399;17513.47459576215;17593.560160995567;18462.538436538656;18638.881667100017;18767.249310027444;19019;19081.236750530377;14267.571972840831;14282.64293392632;14297.213653249171;14333.06835055718;14418.495352662607;18496.630067398844;18647.347342842935;18822.05889705482;18824.52938676544;18906 17:26:56 INFO - PID 12420 | |3;mootools.html;1370.8080868678385;1432.7349440353528;1436.9568912932616;1439.8056262404573;1441.1641248076114;13608.251546164956;14130.22283774392;14166.291685415727;14235.715285694292;14238.644033899158;14083.29583520825;14361.425542978268;14390.1365918045;14402.783958240634;14405;2621.724718904516;2661.4810112028163;2665.746754058361;2666.6000099984963;2666.6400035995084;2648.4438267963656;2698.63568418263;2700.824446410977;2724.101046654599;2725.3322935880637;2672.692640346356;2682.4769170011855;2702.202850159198;2713.552263876458;2724.4687285979244;2621.10882300017;2632.9473410531778;2654.721254268303;2667.6532050833366;2673.9732602673917;2516.7860731837814;2541.6568763216915;2566.268613445159;2567.922962311115;2567.961480577793;13546.525871594546;13829.446822127104;13840.723185536233;13859.861401385959;13863.4454621815;7350.963245183793;7551.24487551246;7556.093268807778;7574.3183113520045;7649.235076492362;4759.5002524734755;4906.975465122688;4930;4933.383327084114;4979.053979743837;1843.1429385335748;1883.565815180594;1911.4361263427322;1921.2315073970383;1953.9413817585496;22251.666225006637;22672.43318917024;22933.426664333358;22946.426339341484;22949.196778112684;6656.933430665631;6856.38258555703;6923.342282483156;6954.617496037767;6997.475189360818;18015.27938882456;18052.097395130455;18085.547861303574;18086.90956545209;18111.18499667518;7412.295831895961;7571.659275332623;7644.350230230381;7941.047074351115;7951.244631759973;6002.759889604367;6225.968870155621;6607.867842643121;6757.898631520531;6795.864082718318;5361.35663720356;5420.945790542044;5535.58483113768;5661.971690141605;5732.942670573241;1679.3534489221738;1696.762453256545;1726.1455579488234;1741.3556983915778;1749.6588165307642;901.4411065139656;909.4225167018991;916.6196028648036;922.2529750901791;929.4051806843626;7442.590657513781;7456.3662088721985;7464.514806537558;7516;7546.471746977769;708.0759608710579;724;969.9224062075017;1013.7009582173276;1014.4167103915278;5208.921866172011;5328.653637513549;5330.040592693353;5352.411234764173;5366.356037275552;18197.636047278982;18470.722939155923;19159.137838797287;19368.4189474316;19390.418287451117;18699.158537865827;18752.156152973148;18905.33831315925;18913;19047.14287857022;10158.39049657023;10383.688489345332;10523.579056837794;10545.261831671864;10550.15598752098;8295.170482951657;8560.186782255676;8587.570621469027;8613.837131987351;8738.912610874064;16272.267747951608;16446.588835279214;17319.7402038967;17384.565385865455;17538.561535961704;16926.492205233862;17328.566785830455;17464.73802892932;17578.560535986704;17584.472465826046;11418;11483.540658373906;11536.826947595624;11596.130290228099;11616.651500455;12719.173253738478;12830.166039207796;12901.096923215286;12925.741485170056;13004.674883127998;10508.527116279633;10864.619738309122;10917.672469825919;10988.175886808682;11105.278156919774;10419.270651054354;10643.361398316125;10661.520231589442;10736.08743256832;10777.191710621579;9208.355415120877;9395.436273823592;9407.388519746195;9417.152456278967;9420.858687119835;7075.858482830212;7117.750878719427;7144.535605185646;7178.425725941807;7196.388306993964;7154.964225178841;7184.425245980205;7370.594617295886;7380.261973802577;7402.037735094404 17:26:56 INFO - PID 12420 | |4;prototype.html;483.6421048424167;501.1080277106749;519.337844248583;520.984370468886;521.8251885618317;6161.969190154048;6205.689715514223;6219.502439804816;6253.593516421435;6278;6086.908696369558;6107.267127944642;6161.784337548187;6168.211218746569;6210.323212732571;5042.84871453857;5102.285680004802;5144.22836574515;5163.302954101205;5176.66351687141;4847.297141914438;5043.773030213649;5080.898382032357;5143.948560514385;5153.6907785532985;4917.164082106033;4928.039032388686;4930.728809915453;4964.652474326798;4972.2044472884345;4930.235813448921;4932.136876046696;4963.60291176705;4975.850724478271;4984.850454486335;4425.446819147606;4438.0694397937;4449.950545004031;4465.106978604292;4467.865964021084;6086.239220097488;6106.175666285084;6121.224844795004;6123.938760612381;6149.200603921507;5726.713664316768;5758.884822303572;5768.442520519437;5774.249347584787;5780.393058728815;6458.483321334282;6494.5453818232745;6511.479081673502;6559.311272316433;6584.440322572587;4838.612910967149;4843.200871856139;4862.343583616202;4896.3389942358035;4898.289747986558;6660.70026848793;6736.5958042517605;6825.249222585511;6845.691943862538;6901.482388820808;4954.331165292711;4957.20684690455;4959.380077490314;4968.453470118284;5018.89962200754;5023.422306434733;5065.316182315414;5087.8473645789945;5090.618203634742;5093.770780314895;5660.660360378391;5698.800541981011;5713.428657134254;5730.856728581819;5768.625039372428;6549.836254093686;6562.77030303937;6590.868182636416;6598.39363451434;6609.9839548938035;1764.2590112152927;1767.76135221746;1769.2480695704273;1771.1675512509357;1796.5508622844288;1162.976740465186;1218.0438355890583;1228.6068458093325;1232.6918270432393;1251.0992085698283;5754.510866576305;5757.913631295534;5771.8557036074435;5780.797672081457;5859.857327821034;6452.935470645328;6588.341165883469;6696.86606267872;6723.394894459424;6770.255271920085;5711.971440142773;5730.512906402919;5742.219911827347;5788.3343415506915;5808.128780682931;3523.7709548879243;3525.3301872644115;3552.5967242938896;3558.8576456941432;3592.670711836637;6494.188226471691;6507.12153859223;6546.770863019771;6577.934220657732;6602.438792702674;6872.278410766898;6938.653067346612;6942.826429339307;6973.232944376115;7000;6471.38521840415;6489.1888513935755;6529.706163222666;6593.241777195588;6598.901016484757;6181.660008699565;6601.603903765789;6661.867482527885;6725.798226053226;6735.124433823572;6542.967285163544;6600.702968366339;6606.042123892104;6629.403353698191;6659.067730517828;6521.804345869631;6532.902006470002;6549.410553050248;6562.5406221564035;6566.8358291041195;4959.743316790779;4969.776360063878;4986.15235409974;4988.700677959189;5031.144705400164;6481.481481481376;6502.479801615765;6631.602103873783;6691.5650482718465;6771.458283337222;6448.645784385331;6463.482921366185;6487.54587178893;6510.8839627122325;6550.181227346582;6505.577137486048;6508.479321654161;6534.901976470452;6535.869282614226;6548.264709851988;6516.0551719999385;6538.771143009972;6543.509236807164;6568.868622627425;6571.638559879252;6677.465802735673;6688.197416310074;6691.799246022627;6696.665166741546;6709.295523970108;6414.294427613052;6463.903041454288;6468.15913931186;6482.837929051811;6500.934990650033 17:26:56 INFO - PID 12420 | |5;yui.html;904.0642934562729;907.9818403631928;925.5279807298284;929.6839074714595;932.2029664636735;18794.90602546987;19918;19944;19954.30159944402;22127.668084978697;22109.778902210972;22715.886420567873;22723.659145112837;22791;22979;999.2805180270194;1019.4036488654147;1023.825949588568;1024.4109636958742;1024.9897501025007;971.13568923658;1020.7550187954912;1033.1837848099992;1033.881103673076;1035.5857656937249;1089.9945500272527;1092.4264761000459;1092.7322805912563;1093.6664317383195;1094.195766111907;1068.0707784227693;1073.726199819049;1081.0540776820283;1081.7241603391124;1084.3981590217427;777.8522080804629;783.7100272899007;783.9333656639193;785.7053604898164;787.350435890387;20465.38603841887;20473.4881627959;20642.896785516128;20794.16823327065;20858.478538036517;21799.78200218009;22068.74509980173;22190.667139992915;22398.552028959493;22534.09863605454;16808.814854069016;16820.74768878468;16821.66356672872;16951.91524042384;17160.141992900306;3686.8525258989607;3693.8522459101605;3716.591174970751;3717.3866312058476;3721.14413684854;126587.36706316502;128323;129977;129978;131136;17859.73210401845;17911.641767164583;18348.174332155086;18407.079646017646;18467;31119.844400777853;32174;32174;32330.676693232766;32342.676573233966;7714.9228507715325;8068.757937261891;9197.49413782235;9312.8603070954;9533.761655958519;4356.128774245164;4383.693141480129;4397.780110994501;4408.118376324748;4412.183746006999;5399.919001214985;5435.374931882805;5454;5495.450454954473;5506.229127922094;1059.523214553454;1078.5146683992234;1089.4280502736126;1091.4651820608003;1097.5280629329466;672.5930811858852;674.6727836999052;685.4139710547411;698.8742026435291;700.0339531446571;11966.341851198094;11969.521219151136;12132.452185041064;12450.190737602208;13428.19430834153;675.861448403086;678.1895634716565;691.0705101638289;695.9199692035379;722.7145277615313;5958.404159584007;5990.64056156632;6074.574779765374;6191.19514463117;6216.875662486816;105204;106561.46719266509;108346;109142;109362;95188;96624.51687741517;98051.50974245225;99140;99250.50374748225;84463;84616.57691711502;84929;86352.56823715966;88528.5573572128;12794.488220471449;13179.802302965272;13290.800637990631;13323.66690832737;13433.462661493431;38732.41901371425;39104.21791564096;39627.80186099051;40310.596894030685;40795.77612671625;50046.499535004186;50198;50360.748196258784;50394.244086338;51694.48305516897;18891.43325700231;20664.380068597966;20993;21143.57712845765;21387.144514219257;23928.521429571658;23997.760022399554;24111.397215069763;24236.666983315383;24615.261542153763;17759;18523.44429667112;18983.525411864815;19494.31769888047;20001.399958001282;19697.901510492356;19719.704204437232;20046.699299510812;20896.791032089484;22008.669869952282;19357.806421935602;19367;19513.512162196057;20908.268210612554;21170;12831.422585983466;13256.138351007154;13453.46186152543;13520.59438216855;13758.380872860946;12668.493260269486;13146.145500542434;13292.401841916944;13512;14925.776113358092 17:26:56 INFO - PID 12420 | __end_tp_report 17:26:56 INFO - PID 12420 | __start_cc_report 17:26:56 INFO - PID 12420 | _x_x_mozilla_cycle_collect,353 17:26:56 INFO - PID 12420 | __end_cc_report 17:26:56 INFO - PID 12420 | __startTimestamp1503016016012__endTimestamp 17:26:56 INFO - PID 12420 | 17:26:56 INFO - PID 12420 | ------- Summary: start ------- 17:26:56 INFO - PID 12420 | Number of tests: 6 17:26:56 INFO - PID 12420 | 17:26:56 INFO - PID 12420 | [#0] dojo.html Cycles:165 Average:6127.66 Median:6375.62 stddev:719.78 (11.3%) stddev-sans-first:682.69 17:26:56 INFO - PID 12420 | Values: 3137.1 3153.6 3178.4 3206.7 3211.0 6231.4 6283.1 6297.4 6354.2 6380.9 6073.9 6157.8 6159.2 6171.9 6181.9 5670.2 5684.3 5719.5 5721.7 5727.0 5772.6 5785.1 5808.6 5815.0 5869.5 5711.6 5761.5 5787.7 5815.0 5860.4 5537.9 5598.2 5635.5 5684.9 5774.5 5565.0 5580.2 5654.3 5659.3 5673.1 5978.1 6044.4 6101.2 6102.2 6164.9 6565.3 6576.7 6600.6 6607.3 6612.8 6655.8 6670.2 6672.7 6673.7 6681.3 6150.6 6165.3 6172.4 6234.3 6255.3 6876.8 6920.2 6956.9 6982.1 7006.0 6512.3 6534.4 6564.3 6630.7 6654.7 6548.0 6652.1 6688.0 6727.9 6734.6 6557.2 6570.5 6583.9 6609.2 6648.7 6678.6 6694.3 6700.6 6722.5 6729.3 5386.1 5457.5 5461.6 5465.0 5480.8 4508.2 4566.8 4592.6 4603.5 4613.2 5651.3 5672.1 5748.6 5755.8 5762.0 6724.7 6731.7 6733.7 6754.5 6758.6 5687.5 5769.5 5778.9 5826.9 5842.3 5749.0 5835.3 5858.2 5883.5 5929.3 6418.9 6429.0 6435.6 6435.6 6438.9 6543.9 6628.2 6640.6 6644.4 6740.1 6449.7 6458.7 6458.9 6469.6 6470.8 6506.6 6539.8 6541.7 6562.2 6608.9 6608.7 6709.3 6711.2 6772.4 6792.8 6355.9 6391.3 6398.1 6398.5 6446.8 6371.7 6375.6 6385.4 6387.6 6388.5 6086.1 6324.1 6339.5 6452.8 6456.4 6513.4 6574.9 6613.8 6641.7 6684.5 6159.7 6308.2 6341.4 6385.2 6457.4 17:26:56 INFO - PID 12420 | 17:26:56 INFO - PID 12420 | [#1] ext.html Cycles:180 Average:38817.59 Median:35982.37 stddev:53541.78 (148.8%) stddev-sans-first:53615.94 17:26:56 INFO - PID 12420 | Values: 817.0 834.3 851.4 868.3 873.2 43062.6 43193.4 43523.6 43560.6 43598.8 38729.4 38798.0 38931.4 39256.2 39351.2 6945.4 7075.9 7086.3 7103.3 7107.9 6980.8 6981.6 7054.8 7060.2 7064.9 7722.1 7776.4 7785.3 7858.1 7891.3 7676.4 7753.8 7754.7 7769.8 7847.5 7631.7 7647.8 7702.8 7789.3 7895.4 39336.2 39759.8 39784.4 39813.2 39942.4 3563.3 3578.6 3586.7 3589.4 3595.7 31272.8 31469.0 31588.0 31882.8 32116.2 5084.9 5113.9 5134.5 5145.2 5161.7 188113.0 188161.0 189522.0 190884.0 190937.0 51638.7 51722.2 51784.0 51784.7 51920.7 52453.2 52498.7 52506.5 52521.2 52681.2 16544.4 16762.7 16784.9 16813.9 16816.8 13689.3 13754.0 13754.2 13767.4 13778.0 14748.9 14915.6 15069.2 15070.8 15187.2 5902.9 5926.4 5949.6 5965.9 6108.9 978.4 1005.6 1009.3 1015.5 1021.1 22130.6 22780.7 22786.3 22845.5 22859.1 1108.1 1110.4 1118.2 1121.3 1129.5 12029.3 12187.6 12233.7 16344.3 16580.8 223782.0 226027.0 227105.0 227379.0 227611.0 58541.7 59273.0 59790.7 59945.4 60109.4 1487.7 1509.7 1521.0 1521.2 1530.2 27649.4 27693.2 27720.4 27731.3 27805.7 53161.2 53212.7 53562.5 53602.7 53944.0 200937.0 201228.0 201926.0 202164.0 202407.0 35832.8 36251.5 36365.5 36664.8 36750.3 44288.8 45608.3 46698.3 46859.5 46867.5 32810.5 32956.0 33124.5 33131.7 33447.0 32643.0 33365.3 33419.0 33802.0 34159.8 35959.3 36005.5 36040.5 36152.8 36293.0 32376.8 32463.5 32837.5 33116.5 33415.0 22897.0 24034.2 24326.4 25269.9 25486.7 17:26:56 INFO - PID 12420 | 17:26:56 INFO - PID 12420 | [#2] jquery.html Cycles:180 Average:35488.75 Median:23598.21 stddev:83710.74 (354.7%) stddev-sans-first:83904.51 17:26:56 INFO - PID 12420 | Values: 569.8 576.2 591.0 593.1 601.1 22912.1 23755.8 23809.4 23851.0 23906.6 24787.4 27023.2 27060.7 27097.6 27191.2 6640.7 6694.6 6746.4 6762.0 6775.1 5960.7 6547.6 6683.8 6764.0 6766.8 6451.6 6452.2 6456.6 6466.4 6467.2 6472.3 6489.1 6500.9 6502.4 6517.2 6023.5 6056.6 6063.3 6069.2 6084.6 29355.1 29442.7 29912.4 30233.0 30604.7 1906.0 1951.5 1953.7 1957.5 1963.5 19486.2 19830.6 20194.4 20968.3 21009.2 2389.3 2410.1 2412.2 2418.7 2475.4 140142.0 142561.7 142759.3 143103.3 143655.3 14143.2 14693.7 15009.5 15464.4 15521.8 23252.7 23281.5 23292.0 23386.5 23395.9 10281.8 10438.3 10503.7 10511.8 10563.2 9750.2 9862.7 9901.7 9908.1 9966.3 8918.2 9200.4 9310.8 9346.3 9646.8 2802.4 2820.5 2872.5 2900.6 2954.3 945.3 961.6 979.9 982.7 999.6 19367.2 24138.5 24962.4 25143.9 25191.6 1004.5 1047.4 1054.9 1068.1 1071.4 10665.0 10819.2 10893.5 10902.8 11007.1 480331.0 495782.0 497472.0 499716.0 502843.0 120339.4 121873.0 123685.4 124460.4 126384.0 1280.6 1292.5 1302.2 1307.5 1319.1 17359.7 17612.8 17806.0 17833.1 17953.7 53045.5 53354.5 53768.5 54060.0 55319.4 69900.3 69991.7 73713.0 73929.3 75888.6 14362.5 14513.5 14580.5 14656.2 14689.1 23165.7 23344.6 23430.8 23440.6 23821.6 18274.9 18746.9 18841.0 18870.3 18931.9 16755.2 16910.7 17399.0 17513.5 17593.6 18462.5 18638.9 18767.2 19019.0 19081.2 14267.6 14282.6 14297.2 14333.1 14418.5 18496.6 18647.3 18822.1 18824.5 18906.0 17:26:56 INFO - PID 12420 | 17:26:56 INFO - PID 12420 | [#3] mootools.html Cycles:180 Average:8773.43 Median:2567.94 stddev:5948.01 (231.6%) stddev-sans-first:5938.69 17:26:56 INFO - PID 12420 | Values: 1370.8 1432.7 1437.0 1439.8 1441.2 13608.3 14130.2 14166.3 14235.7 14238.6 14083.3 14361.4 14390.1 14402.8 14405.0 2621.7 2661.5 2665.7 2666.6 2666.6 2648.4 2698.6 2700.8 2724.1 2725.3 2672.7 2682.5 2702.2 2713.6 2724.5 2621.1 2632.9 2654.7 2667.7 2674.0 2516.8 2541.7 2566.3 2567.9 2568.0 13546.5 13829.4 13840.7 13859.9 13863.4 7351.0 7551.2 7556.1 7574.3 7649.2 4759.5 4907.0 4930.0 4933.4 4979.1 1843.1 1883.6 1911.4 1921.2 1953.9 22251.7 22672.4 22933.4 22946.4 22949.2 6656.9 6856.4 6923.3 6954.6 6997.5 18015.3 18052.1 18085.5 18086.9 18111.2 7412.3 7571.7 7644.4 7941.0 7951.2 6002.8 6226.0 6607.9 6757.9 6795.9 5361.4 5420.9 5535.6 5662.0 5732.9 1679.4 1696.8 1726.1 1741.4 1749.7 901.4 909.4 916.6 922.3 929.4 7442.6 7456.4 7464.5 7516.0 7546.5 708.1 724.0 969.9 1013.7 1014.4 5208.9 5328.7 5330.0 5352.4 5366.4 18197.6 18470.7 19159.1 19368.4 19390.4 18699.2 18752.2 18905.3 18913.0 19047.1 10158.4 10383.7 10523.6 10545.3 10550.2 8295.2 8560.2 8587.6 8613.8 8738.9 16272.3 16446.6 17319.7 17384.6 17538.6 16926.5 17328.6 17464.7 17578.6 17584.5 11418.0 11483.5 11536.8 11596.1 11616.7 12719.2 12830.2 12901.1 12925.7 13004.7 10508.5 10864.6 10917.7 10988.2 11105.3 10419.3 10643.4 10661.5 10736.1 10777.2 9208.4 9395.4 9407.4 9417.2 9420.9 7075.9 7117.8 7144.5 7178.4 7196.4 7155.0 7184.4 7370.6 7380.3 7402.0 17:26:56 INFO - PID 12420 | 17:26:56 INFO - PID 12420 | [#4] prototype.html Cycles:180 Average:5517.61 Median:6136.57 stddev:1545.16 (25.2%) stddev-sans-first:1502.59 17:26:56 INFO - PID 12420 | Values: 483.6 501.1 519.3 521.0 521.8 6162.0 6205.7 6219.5 6253.6 6278.0 6086.9 6107.3 6161.8 6168.2 6210.3 5042.8 5102.3 5144.2 5163.3 5176.7 4847.3 5043.8 5080.9 5143.9 5153.7 4917.2 4928.0 4930.7 4964.7 4972.2 4930.2 4932.1 4963.6 4975.9 4984.9 4425.4 4438.1 4450.0 4465.1 4467.9 6086.2 6106.2 6121.2 6123.9 6149.2 5726.7 5758.9 5768.4 5774.2 5780.4 6458.5 6494.5 6511.5 6559.3 6584.4 4838.6 4843.2 4862.3 4896.3 4898.3 6660.7 6736.6 6825.2 6845.7 6901.5 4954.3 4957.2 4959.4 4968.5 5018.9 5023.4 5065.3 5087.8 5090.6 5093.8 5660.7 5698.8 5713.4 5730.9 5768.6 6549.8 6562.8 6590.9 6598.4 6610.0 1764.3 1767.8 1769.2 1771.2 1796.6 1163.0 1218.0 1228.6 1232.7 1251.1 5754.5 5757.9 5771.9 5780.8 5859.9 6452.9 6588.3 6696.9 6723.4 6770.3 5712.0 5730.5 5742.2 5788.3 5808.1 3523.8 3525.3 3552.6 3558.9 3592.7 6494.2 6507.1 6546.8 6577.9 6602.4 6872.3 6938.7 6942.8 6973.2 7000.0 6471.4 6489.2 6529.7 6593.2 6598.9 6181.7 6601.6 6661.9 6725.8 6735.1 6543.0 6600.7 6606.0 6629.4 6659.1 6521.8 6532.9 6549.4 6562.5 6566.8 4959.7 4969.8 4986.2 4988.7 5031.1 6481.5 6502.5 6631.6 6691.6 6771.5 6448.6 6463.5 6487.5 6510.9 6550.2 6505.6 6508.5 6534.9 6535.9 6548.3 6516.1 6538.8 6543.5 6568.9 6571.6 6677.5 6688.2 6691.8 6696.7 6709.3 6414.3 6463.9 6468.2 6482.8 6500.9 17:26:56 INFO - PID 12420 | 17:26:56 INFO - PID 12420 | [#5] yui.html Cycles:180 Average:23803.73 Median:21593.46 stddev:31483.95 (145.8%) stddev-sans-first:31525.31 17:26:56 INFO - PID 12420 | Values: 904.1 908.0 925.5 929.7 932.2 18794.9 19918.0 19944.0 19954.3 22127.7 22109.8 22715.9 22723.7 22791.0 22979.0 999.3 1019.4 1023.8 1024.4 1025.0 971.1 1020.8 1033.2 1033.9 1035.6 1090.0 1092.4 1092.7 1093.7 1094.2 1068.1 1073.7 1081.1 1081.7 1084.4 777.9 783.7 783.9 785.7 787.4 20465.4 20473.5 20642.9 20794.2 20858.5 21799.8 22068.7 22190.7 22398.6 22534.1 16808.8 16820.7 16821.7 16951.9 17160.1 3686.9 3693.9 3716.6 3717.4 3721.1 126587.4 128323.0 129977.0 129978.0 131136.0 17859.7 17911.6 18348.2 18407.1 18467.0 31119.8 32174.0 32174.0 32330.7 32342.7 7714.9 8068.8 9197.5 9312.9 9533.8 4356.1 4383.7 4397.8 4408.1 4412.2 5399.9 5435.4 5454.0 5495.5 5506.2 1059.5 1078.5 1089.4 1091.5 1097.5 672.6 674.7 685.4 698.9 700.0 11966.3 11969.5 12132.5 12450.2 13428.2 675.9 678.2 691.1 695.9 722.7 5958.4 5990.6 6074.6 6191.2 6216.9 105204.0 106561.5 108346.0 109142.0 109362.0 95188.0 96624.5 98051.5 99140.0 99250.5 84463.0 84616.6 84929.0 86352.6 88528.6 12794.5 13179.8 13290.8 13323.7 13433.5 38732.4 39104.2 39627.8 40310.6 40795.8 50046.5 50198.0 50360.7 50394.2 51694.5 18891.4 20664.4 20993.0 21143.6 21387.1 23928.5 23997.8 24111.4 24236.7 24615.3 17759.0 18523.4 18983.5 19494.3 20001.4 19697.9 19719.7 20046.7 20896.8 22008.7 19357.8 19367.0 19513.5 20908.3 21170.0 12831.4 13256.1 13453.5 13520.6 13758.4 12668.5 13146.1 13292.4 13512.0 14925.8 17:26:56 INFO - PID 12420 | -------- Summary: end -------- 17:26:56 INFO - PID 12420 | 17:26:56 INFO - TEST-INFO | 12420: exit 0 17:26:56 INFO - TEST-OK | dromaeo_css | took 1111084ms 17:26:56 INFO - TEST-START | kraken 17:26:56 INFO - Initialising browser for kraken test... 17:26:56 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:54689/getInfo.html -profile /tmp/tmpWo29FD/profile 17:26:56 INFO - TEST-INFO | started process 12784 (/builds/slave/test/build/application/firefox/firefox http://localhost:54689/getInfo.html) 17:27:02 INFO - TEST-INFO | 12784: exit 0 17:27:02 INFO - Browser initialized. 17:27:02 INFO - Running cycle 1/1 for kraken test... 17:27:02 INFO - TEST-INFO | started process 12957 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWo29FD/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 17:27:03 INFO - PID 12957 | 17:27:03 INFO - PID 12957 | (/builds/slave/test/build/application/firefox/firefox:13005): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 17:27:03 INFO - PID 12957 | 17:27:13 INFO - PID 12957 | RSS: Main: 163692544 17:27:13 INFO - PID 12957 | 17:27:16 INFO - PID 12957 | Cycle 1(1): loaded http://localhost:54689/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:54689/tests/kraken/driver.html?testName=audio-beat-detection) 17:27:17 INFO - PID 12957 | RSS: Main: 170205184 17:27:17 INFO - PID 12957 | 17:27:19 INFO - PID 12957 | Cycle 1(1): loaded http://localhost:54689/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:54689/tests/kraken/driver.html?testName=audio-dft) 17:27:20 INFO - PID 12957 | RSS: Main: 170237952 17:27:20 INFO - PID 12957 | 17:27:23 INFO - PID 12957 | Cycle 1(1): loaded http://localhost:54689/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:54689/tests/kraken/driver.html?testName=audio-fft) 17:27:24 INFO - PID 12957 | RSS: Main: 165081088 17:27:24 INFO - PID 12957 | 17:27:26 INFO - PID 12957 | Cycle 1(1): loaded http://localhost:54689/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:54689/tests/kraken/driver.html?testName=audio-oscillator) 17:27:26 INFO - PID 12957 | RSS: Main: 165715968 17:27:26 INFO - PID 12957 | 17:27:29 INFO - PID 12957 | Cycle 1(1): loaded http://localhost:54689/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:54689/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:27:29 INFO - PID 12957 | RSS: Main: 165941248 17:27:29 INFO - PID 12957 | 17:27:32 INFO - PID 12957 | Cycle 1(1): loaded http://localhost:54689/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:54689/tests/kraken/driver.html?testName=imaging-darkroom) 17:27:33 INFO - PID 12957 | RSS: Main: 169082880 17:27:33 INFO - PID 12957 | 17:27:36 INFO - PID 12957 | Cycle 1(1): loaded http://localhost:54689/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:54689/tests/kraken/driver.html?testName=imaging-desaturate) 17:27:37 INFO - PID 12957 | RSS: Main: 168972288 17:27:37 INFO - PID 12957 | 17:27:40 INFO - PID 12957 | Cycle 1(1): loaded http://localhost:54689/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:54689/tests/kraken/driver.html?testName=json-parse-financial) 17:27:41 INFO - PID 12957 | RSS: Main: 169406464 17:27:41 INFO - PID 12957 | 17:27:42 INFO - PID 12957 | Cycle 1(1): loaded http://localhost:54689/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:54689/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:27:43 INFO - PID 12957 | RSS: Main: 169377792 17:27:43 INFO - PID 12957 | 17:27:45 INFO - PID 12957 | Cycle 1(1): loaded http://localhost:54689/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:54689/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:27:45 INFO - PID 12957 | RSS: Main: 169259008 17:27:45 INFO - PID 12957 | 17:27:47 INFO - PID 12957 | Cycle 1(1): loaded http://localhost:54689/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:54689/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:27:48 INFO - PID 12957 | RSS: Main: 169287680 17:27:48 INFO - PID 12957 | 17:27:51 INFO - PID 12957 | Cycle 1(1): loaded http://localhost:54689/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:54689/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:27:51 INFO - PID 12957 | RSS: Main: 169746432 17:27:51 INFO - PID 12957 | 17:27:54 INFO - PID 12957 | Cycle 1(1): loaded http://localhost:54689/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:54689/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:27:55 INFO - PID 12957 | RSS: Main: 170303488 17:27:55 INFO - PID 12957 | 17:27:57 INFO - PID 12957 | Cycle 1(1): loaded http://localhost:54689/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:54689/tests/kraken/driver.html?testName=ai-astar) 17:27:57 INFO - PID 12957 | RSS: Main: 171761664 17:27:57 INFO - PID 12957 | 17:27:57 INFO - PID 12957 | __start_tp_report 17:27:57 INFO - PID 12957 | _x_x_mozilla_page_load 17:27:57 INFO - PID 12957 | _x_x_mozilla_page_load_details 17:27:57 INFO - PID 12957 | |i|pagename|runs| 17:27:57 INFO - PID 12957 | |0;ai-astar;101;110;102;109;108;116;111;99;110;110 17:27:57 INFO - PID 12957 | |1;audio-beat-detection;152;118;140;183;123;146;143;118;179;119 17:27:57 INFO - PID 12957 | |2;audio-dft;164;165;163;163;163;162;166;171;166;164 17:27:57 INFO - PID 12957 | |3;audio-fft;75;76;78;181;76;75;75;74;155;75 17:27:57 INFO - PID 12957 | |4;audio-oscillator;79;79;130;82;80;80;126;82;83;129 17:27:57 INFO - PID 12957 | |5;imaging-gaussian-blur;117;115;115;116;115;115;115;115;114;115 17:27:57 INFO - PID 12957 | |6;imaging-darkroom;152;154;151;151;152;152;150;151;151;152 17:27:57 INFO - PID 12957 | |7;imaging-desaturate;94;95;94;95;94;94;95;96;95;94 17:27:57 INFO - PID 12957 | |8;json-parse-financial;58;53;54;55;56;54;54;53;54;54 17:27:57 INFO - PID 12957 | |9;json-stringify-tinderbox;55;55;55;55;55;55;56;55;55;57 17:27:57 INFO - PID 12957 | |10;stanford-crypto-aes;77;83;76;77;76;79;76;79;77;78 17:27:57 INFO - PID 12957 | |11;stanford-crypto-ccm;132;129;131;129;117;124;121;129;123;159 17:27:57 INFO - PID 12957 | |12;stanford-crypto-pbkdf2;176;176;196;191;173;173;188;178;173;175 17:27:57 INFO - PID 12957 | |13;stanford-crypto-sha256-iterative;69;67;68;69;68;72;70;71;67;66 17:27:57 INFO - PID 12957 | __end_tp_report 17:27:57 INFO - PID 12957 | __start_cc_report 17:27:57 INFO - PID 12957 | _x_x_mozilla_cycle_collect,982 17:27:57 INFO - PID 12957 | __end_cc_report 17:27:57 INFO - PID 12957 | __startTimestamp1503016077544__endTimestamp 17:27:57 INFO - PID 12957 | 17:27:57 INFO - PID 12957 | ------- Summary: start ------- 17:27:57 INFO - PID 12957 | Number of tests: 14 17:27:57 INFO - PID 12957 | 17:27:57 INFO - PID 12957 | [#0] ai-astar Cycles:10 Average:107.60 Median:110.00 stddev:5.27 (4.8%) stddev-sans-first:5.02 17:27:57 INFO - PID 12957 | Values: 101.0 110.0 102.0 109.0 108.0 116.0 111.0 99.0 110.0 110.0 17:27:57 INFO - PID 12957 | 17:27:57 INFO - PID 12957 | [#1] audio-beat-detection Cycles:10 Average:142.10 Median:144.50 stddev:24.07 (16.7%) stddev-sans-first:25.26 17:27:57 INFO - PID 12957 | Values: 152.0 118.0 140.0 183.0 123.0 146.0 143.0 118.0 179.0 119.0 17:27:57 INFO - PID 12957 | 17:27:57 INFO - PID 12957 | [#2] audio-dft Cycles:10 Average:164.70 Median:164.50 stddev:2.58 (1.6%) stddev-sans-first:2.73 17:27:57 INFO - PID 12957 | Values: 164.0 165.0 163.0 163.0 163.0 162.0 166.0 171.0 166.0 164.0 17:27:57 INFO - PID 12957 | 17:27:57 INFO - PID 12957 | [#3] audio-fft Cycles:10 Average:94.00 Median:75.00 stddev:39.49 (52.7%) stddev-sans-first:41.29 17:27:57 INFO - PID 12957 | Values: 75.0 76.0 78.0 181.0 76.0 75.0 75.0 74.0 155.0 75.0 17:27:57 INFO - PID 12957 | 17:27:57 INFO - PID 12957 | [#4] audio-oscillator Cycles:10 Average:95.00 Median:80.00 stddev:23.06 (28.8%) stddev-sans-first:23.72 17:27:57 INFO - PID 12957 | Values: 79.0 79.0 130.0 82.0 80.0 80.0 126.0 82.0 83.0 129.0 17:27:57 INFO - PID 12957 | 17:27:57 INFO - PID 12957 | [#5] imaging-gaussian-blur Cycles:10 Average:115.20 Median:115.00 stddev:0.79 (0.7%) stddev-sans-first:0.50 17:27:57 INFO - PID 12957 | Values: 117.0 115.0 115.0 116.0 115.0 115.0 115.0 115.0 114.0 115.0 17:27:57 INFO - PID 12957 | 17:27:57 INFO - PID 12957 | [#6] imaging-darkroom Cycles:10 Average:151.60 Median:152.00 stddev:1.07 (0.7%) stddev-sans-first:1.13 17:27:57 INFO - PID 12957 | Values: 152.0 154.0 151.0 151.0 152.0 152.0 150.0 151.0 151.0 152.0 17:27:57 INFO - PID 12957 | 17:27:57 INFO - PID 12957 | [#7] imaging-desaturate Cycles:10 Average:94.60 Median:95.00 stddev:0.70 (0.7%) stddev-sans-first:0.71 17:27:57 INFO - PID 12957 | Values: 94.0 95.0 94.0 95.0 94.0 94.0 95.0 96.0 95.0 94.0 17:27:57 INFO - PID 12957 | 17:27:57 INFO - PID 12957 | [#8] json-parse-financial Cycles:10 Average:54.50 Median:54.00 stddev:1.51 (2.8%) stddev-sans-first:0.93 17:27:57 INFO - PID 12957 | Values: 58.0 53.0 54.0 55.0 56.0 54.0 54.0 53.0 54.0 54.0 17:27:57 INFO - PID 12957 | 17:27:57 INFO - PID 12957 | [#9] json-stringify-tinderbox Cycles:10 Average:55.30 Median:55.00 stddev:0.67 (1.2%) stddev-sans-first:0.71 17:27:57 INFO - PID 12957 | Values: 55.0 55.0 55.0 55.0 55.0 55.0 56.0 55.0 55.0 57.0 17:27:57 INFO - PID 12957 | 17:27:57 INFO - PID 12957 | [#10] stanford-crypto-aes Cycles:10 Average:77.80 Median:77.50 stddev:2.15 (2.8%) stddev-sans-first:2.26 17:27:57 INFO - PID 12957 | Values: 77.0 83.0 76.0 77.0 76.0 79.0 76.0 79.0 77.0 78.0 17:27:57 INFO - PID 12957 | 17:27:57 INFO - PID 12957 | [#11] stanford-crypto-ccm Cycles:10 Average:129.40 Median:129.00 stddev:11.45 (8.9%) stddev-sans-first:12.11 17:27:57 INFO - PID 12957 | Values: 132.0 129.0 131.0 129.0 117.0 124.0 121.0 129.0 123.0 159.0 17:27:57 INFO - PID 12957 | 17:27:57 INFO - PID 12957 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:179.90 Median:177.00 stddev:8.49 (4.8%) stddev-sans-first:8.89 17:27:57 INFO - PID 12957 | Values: 176.0 176.0 196.0 191.0 173.0 173.0 188.0 178.0 173.0 175.0 17:27:57 INFO - PID 12957 | 17:27:57 INFO - PID 12957 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.70 Median:69.00 stddev:1.89 (2.7%) stddev-sans-first:2.00 17:27:57 INFO - PID 12957 | Values: 69.0 67.0 68.0 69.0 68.0 72.0 70.0 71.0 67.0 66.0 17:27:57 INFO - PID 12957 | -------- Summary: end -------- 17:27:57 INFO - PID 12957 | 17:27:57 INFO - PID 12957 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 17:27:58 INFO - TEST-INFO | 12957: exit 0 17:27:58 INFO - TEST-OK | kraken | took 61474ms 17:27:58 INFO - SUITE-END | took 1172s 17:27:58 INFO - Completed test suite (00:19:33) 17:27:58 INFO - javascript benchmark 17:27:58 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8598.647484955018, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3137.137287246007, 3153.558501809747, 3178.3961047400994, 3206.7434605231583, 3211.020638705194, 6231.408016238462, 6283.120363149163, 6297.3702629737, 6354.205724284465, 6380.872382552347, 6073.9392606073925, 6157.7536898524, 6159.168512250856, 6171.9382806171925, 6181.918164321237, 5670.177824215507, 5684.317881854184, 5719.485246327829, 5721.713914304289, 5727.026405511052, 5772.595918285721, 5785.074388097905, 5808.59339846211, 5815.0, 5869.530437564985, 5711.628744131618, 5761.510271626917, 5787.681677507735, 5814.970925145369, 5860.355360910296, 5537.889242215173, 5598.188262701926, 5635.520980716644, 5684.886302273972, 5774.538036957033, 5565.0, 5580.218769372291, 5654.321481422215, 5659.292588426447, 5673.063944449161, 5978.073398623221, 6044.395560443921, 6101.237345331833, 6102.176206212149, 6164.907526387108, 6565.343465653396, 6576.704048317837, 6600.603963762142, 6607.273199948002, 6612.801615951529, 6655.833604159886, 6670.199576050856, 6672.733090676367, 6673.699683514254, 6681.331866813329, 6150.569460137792, 6165.32181460039, 6172.382761723837, 6234.314225435199, 6255.343188965184, 6876.759313424006, 6920.204176519765, 6956.930430695729, 6982.092327997328, 7006.0, 6512.348765123545, 6534.379233972765, 6564.310747371553, 6630.734770609218, 6654.73381064752, 6547.9672601636685, 6652.135222421054, 6687.966560167168, 6727.865442691119, 6734.595924244561, 6557.245916719638, 6570.540062195696, 6583.9136542470915, 6609.173853268341, 6648.66756662165, 6678.632675202911, 6694.297098804653, 6700.564463309869, 6722.462203023746, 6729.327067293231, 5386.057439948072, 5457.508824205841, 5461.590380721383, 5465.043617366945, 5480.835574932758, 4508.165989291926, 4566.794494247767, 4592.609628181575, 4603.539646035437, 4613.192691279013, 5651.265335506358, 5672.12082127271, 5748.626339287933, 5755.798547050833, 5762.049261871828, 6724.731010759515, 6731.697073631698, 6733.696983635748, 6754.45964322853, 6758.560693554903, 5687.488126068673, 5769.451902069297, 5778.88442231153, 5826.912596311059, 5842.269716285465, 5749.022666146765, 5835.270591176103, 5858.209141765892, 5883.529317654577, 5929.3181284152015, 6418.871622567616, 6429.0, 6435.581687190318, 6435.613863168225, 6438.871222575616, 6543.869122617616, 6628.237752658506, 6640.634765087966, 6644.368784965421, 6740.090087838079, 6449.742300251406, 6458.741650333934, 6458.903116453163, 6469.611823290617, 6470.773522926864, 6506.642134682638, 6539.771108011387, 6541.738330466918, 6562.179727534059, 6608.867822643617, 6608.735650574115, 6709.261981181969, 6711.228208756055, 6772.390484856386, 6792.796216113525, 6355.936440635719, 6391.3289104643345, 6398.1362516059735, 6398.488120950406, 6446.774362897276, 6371.681415929278, 6375.6174629522375, 6385.393387628168, 6387.552871298964, 6388.456981156468, 6086.147939288415, 6324.114623952558, 6339.461145802658, 6452.774152904626, 6456.386643268882, 6513.446357059703, 6574.868502630016, 6613.801585952429, 6641.734330626914, 6684.4652427804685, 6159.722812473539, 6308.211473565804, 6341.429271365415, 6385.233771947396, 6457.354264573693], "value": 6074.161029689336, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [816.9550674712889, 834.2783492279173, 851.4423052900349, 868.3227082875358, 873.1617647058823, 43062.56937430625, 43193.35209971849, 43523.56476435235, 43560.56439435605, 43598.782006090005, 38729.41905871414, 38798.0, 38931.41602875959, 39256.21487570247, 39351.21297574047, 6945.374916257536, 7075.85848283034, 7086.255943125975, 7103.25415831338, 7107.928920710804, 6980.825479363031, 6981.581105133709, 7054.823629409255, 7060.188078371002, 7064.858702825941, 7722.1119571249465, 7776.416768742339, 7785.260400261966, 7858.096318923312, 7891.329237014861, 7676.385889128856, 7753.844923101535, 7754.689812407497, 7769.8057548561455, 7847.5291482510665, 7631.694732210705, 7647.808804779925, 7702.768916932501, 7789.337906277973, 7895.407844411692, 39336.21327573433, 39759.80120099381, 39784.40323395151, 39813.20373592541, 39942.400863987066, 3563.322968635977, 3578.6421357864265, 3586.7130629549574, 3589.407747721623, 3595.676389124965, 31272.843635781675, 31469.0, 31588.0, 31882.840585796923, 32116.197095072577, 5084.949150508522, 5113.872153196163, 5134.512221339004, 5145.228215767665, 5161.664491808058, 188113.0, 188161.0, 189522.0, 190884.0, 190937.0, 51638.74180629073, 51722.224166637534, 51784.0, 51784.74107629438, 51920.74039629778, 52453.213201802006, 52498.73750631299, 52506.47493525016, 52521.212181817304, 52681.2097818533, 16544.42094526686, 16762.664746705, 16784.916075419544, 16813.91593042027, 16816.83183168177, 13689.31553422325, 13754.0, 13754.243516606482, 13767.449302028008, 13778.0, 14748.92625536887, 14915.552533424014, 15069.17119558413, 15070.849291507164, 15187.240637968278, 5902.8819423611285, 5926.436988486087, 5949.583529153005, 5965.910511342333, 6108.938910610926, 978.4229889629142, 1005.627917670452, 1009.3388830316155, 1015.4973288222229, 1021.0759262867117, 22130.557388852132, 22780.658290125662, 22786.316410507712, 22845.543089138126, 22859.085636574684, 1108.0692218536308, 1110.4059328259343, 1118.189312748251, 1121.2879821313525, 1129.5312445335094, 12029.278243305429, 12187.568679946406, 12233.694157645952, 16344.264508097163, 16580.83419165817, 223782.0, 226027.0, 227105.0, 227379.0, 227611.0, 58541.70729146327, 59273.0, 59790.70104649536, 59945.40054599485, 60109.39890601126, 1487.6950225203807, 1509.6527798606382, 1520.9619759506102, 1521.193767303331, 1530.2425299476608, 27649.447011060067, 27693.169204923885, 27720.445591088468, 27731.336119832875, 27805.721942780314, 53161.202581960526, 53212.73393633007, 53562.46437535575, 53602.731986339815, 53944.0, 200937.0, 201228.0, 201926.0, 202164.0, 202407.0, 35832.820835895654, 36251.45622815713, 36365.454518181716, 36664.81667591645, 36750.26499470049, 44288.77855610701, 45608.31587526256, 46698.29952550647, 46859.53140468552, 46867.53132468768, 32810.50784238191, 32956.0, 33124.50313245255, 33131.668683312855, 33446.99659010234, 32643.0, 33365.332693346485, 33419.0, 33802.0, 34159.829200853834, 35959.28081438304, 36005.45991810073, 36040.4593931086, 36152.819235903655, 36293.0, 32376.83811580927, 32463.513047303837, 32837.50743738894, 33116.503252451716, 33415.0, 22897.0, 24034.158804441762, 24326.391840204138, 25269.87365063163, 25486.745132548436], "value": 17760.180256975727, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [569.8375962850588, 576.2336092996316, 590.9763609455622, 593.1044123373706, 601.1133577972491, 22912.083516659335, 23755.76244237557, 23809.40476488089, 23851.0, 23906.641400378965, 24787.380315492122, 27023.189304320902, 27060.729392706115, 27097.593536096974, 27191.184264472096, 6640.667966601674, 6694.564853284545, 6746.359095885908, 6761.985702144693, 6775.119234499508, 5960.672163031031, 6547.57440766351, 6683.799486015428, 6763.966180169093, 6766.763163289286, 6451.612903225821, 6452.193475815523, 6456.612603243821, 6466.35336466352, 6467.191601049869, 6472.255690595594, 6489.123968264318, 6500.8699826003685, 6502.382273683992, 6517.152770139875, 6023.488003519706, 6056.636601803906, 6063.272407311151, 6069.211002569682, 6084.574079814415, 29355.11934641964, 29442.70557294421, 29912.401751965055, 30233.0, 30604.693953060407, 1905.9523511912175, 1951.4535929939639, 1953.7069439584034, 1957.4812674641232, 1963.4894927319, 19486.220551177936, 19830.603387932162, 20194.39416817498, 20968.266110686054, 21009.159633614636, 2389.342930694073, 2410.14439873844, 2412.16780210827, 2418.73112675433, 2475.3687809608437, 140142.0, 142561.72314830573, 142759.28620356935, 143103.28448357797, 143655.2817235928, 14143.22212278314, 14693.7224730167, 15009.474668386554, 15464.381424742884, 15521.758259339225, 23252.65121023186, 23281.534369312856, 23292.0, 23386.532269354517, 23395.883020584788, 10281.845772313422, 10438.269321147447, 10503.737406564896, 10511.84232236517, 10563.154947604173, 9750.171235445066, 9862.733615872492, 9901.653442129491, 9908.108270255712, 9966.302358834811, 8918.1973622373, 9200.35597508168, 9310.767230819149, 9346.299027572959, 9646.758831029281, 2802.4114935863695, 2820.464111818748, 2872.540393537024, 2900.608417863604, 2954.290970167144, 945.2674177512483, 961.6345788600287, 979.8726165598426, 982.7002764156858, 999.5551979369257, 19367.225310987684, 24138.51722965531, 24962.37594060163, 25143.87428062848, 25191.62212566813, 1004.5228516454625, 1047.4448542272607, 1054.926155169146, 1068.076114161245, 1071.4482041748506, 10665.040146386862, 10819.242653014371, 10893.455327233607, 10902.836457453144, 11007.06439952613, 480331.0, 495782.0, 497472.0, 499716.0, 502843.0, 120339.39830300793, 121873.0, 123685.38157309336, 124460.37769811274, 126384.0, 1280.603013065934, 1292.4507084489055, 1302.179626835088, 1307.4639397846838, 1319.12937461277, 17359.652806943537, 17612.82387176163, 17806.0, 17833.10834458298, 17953.73069403934, 53045.4695453056, 53354.46645533495, 53768.462315376346, 54060.0, 55319.44680553143, 69900.30099698938, 69991.65004174947, 73713.0, 73929.26070739224, 75888.62055689686, 14362.497312594009, 14513.492027778977, 14580.489682861049, 14656.193909334663, 14689.118652880861, 23165.652515212623, 23344.6498302529, 23430.76569234354, 23440.64839027382, 23821.642675359537, 18274.90862545679, 18746.906265468584, 18841.0, 18870.3395381161, 18931.90534047321, 16755.1622418881, 16910.746338805173, 17399.0, 17513.47459576215, 17593.560160995567, 18462.538436538656, 18638.881667100017, 18767.249310027444, 19019.0, 19081.236750530377, 14267.571972840831, 14282.64293392632, 14297.213653249171, 14333.06835055718, 14418.495352662607, 18496.630067398844, 18647.347342842935, 18822.05889705482, 18824.52938676544, 18906.0], "value": 12207.190653488658, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1370.8080868678385, 1432.7349440353528, 1436.9568912932616, 1439.8056262404573, 1441.1641248076114, 13608.251546164956, 14130.22283774392, 14166.291685415727, 14235.715285694292, 14238.644033899158, 14083.29583520825, 14361.425542978268, 14390.1365918045, 14402.783958240634, 14405.0, 2621.724718904516, 2661.4810112028163, 2665.746754058361, 2666.6000099984963, 2666.6400035995084, 2648.4438267963656, 2698.63568418263, 2700.824446410977, 2724.101046654599, 2725.3322935880637, 2672.692640346356, 2682.4769170011855, 2702.202850159198, 2713.552263876458, 2724.4687285979244, 2621.10882300017, 2632.9473410531778, 2654.721254268303, 2667.6532050833366, 2673.9732602673917, 2516.7860731837814, 2541.6568763216915, 2566.268613445159, 2567.922962311115, 2567.961480577793, 13546.525871594546, 13829.446822127104, 13840.723185536233, 13859.861401385959, 13863.4454621815, 7350.963245183793, 7551.24487551246, 7556.093268807778, 7574.3183113520045, 7649.235076492362, 4759.5002524734755, 4906.975465122688, 4930.0, 4933.383327084114, 4979.053979743837, 1843.1429385335748, 1883.565815180594, 1911.4361263427322, 1921.2315073970383, 1953.9413817585496, 22251.666225006637, 22672.43318917024, 22933.426664333358, 22946.426339341484, 22949.196778112684, 6656.933430665631, 6856.38258555703, 6923.342282483156, 6954.617496037767, 6997.475189360818, 18015.27938882456, 18052.097395130455, 18085.547861303574, 18086.90956545209, 18111.18499667518, 7412.295831895961, 7571.659275332623, 7644.350230230381, 7941.047074351115, 7951.244631759973, 6002.759889604367, 6225.968870155621, 6607.867842643121, 6757.898631520531, 6795.864082718318, 5361.35663720356, 5420.945790542044, 5535.58483113768, 5661.971690141605, 5732.942670573241, 1679.3534489221738, 1696.762453256545, 1726.1455579488234, 1741.3556983915778, 1749.6588165307642, 901.4411065139656, 909.4225167018991, 916.6196028648036, 922.2529750901791, 929.4051806843626, 7442.590657513781, 7456.3662088721985, 7464.514806537558, 7516.0, 7546.471746977769, 708.0759608710579, 724.0, 969.9224062075017, 1013.7009582173276, 1014.4167103915278, 5208.921866172011, 5328.653637513549, 5330.040592693353, 5352.411234764173, 5366.356037275552, 18197.636047278982, 18470.722939155923, 19159.137838797287, 19368.4189474316, 19390.418287451117, 18699.158537865827, 18752.156152973148, 18905.33831315925, 18913.0, 19047.14287857022, 10158.39049657023, 10383.688489345332, 10523.579056837794, 10545.261831671864, 10550.15598752098, 8295.170482951657, 8560.186782255676, 8587.570621469027, 8613.837131987351, 8738.912610874064, 16272.267747951608, 16446.588835279214, 17319.7402038967, 17384.565385865455, 17538.561535961704, 16926.492205233862, 17328.566785830455, 17464.73802892932, 17578.560535986704, 17584.472465826046, 11418.0, 11483.540658373906, 11536.826947595624, 11596.130290228099, 11616.651500455, 12719.173253738478, 12830.166039207796, 12901.096923215286, 12925.741485170056, 13004.674883127998, 10508.527116279633, 10864.619738309122, 10917.672469825919, 10988.175886808682, 11105.278156919774, 10419.270651054354, 10643.361398316125, 10661.520231589442, 10736.08743256832, 10777.191710621579, 9208.355415120877, 9395.436273823592, 9407.388519746195, 9417.152456278967, 9420.858687119835, 7075.858482830212, 7117.750878719427, 7144.535605185646, 7178.425725941807, 7196.388306993964, 7154.964225178841, 7184.425245980205, 7370.594617295886, 7380.261973802577, 7402.037735094404], "value": 6431.09498913187, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [483.6421048424167, 501.1080277106749, 519.337844248583, 520.984370468886, 521.8251885618317, 6161.969190154048, 6205.689715514223, 6219.502439804816, 6253.593516421435, 6278.0, 6086.908696369558, 6107.267127944642, 6161.784337548187, 6168.211218746569, 6210.323212732571, 5042.84871453857, 5102.285680004802, 5144.22836574515, 5163.302954101205, 5176.66351687141, 4847.297141914438, 5043.773030213649, 5080.898382032357, 5143.948560514385, 5153.6907785532985, 4917.164082106033, 4928.039032388686, 4930.728809915453, 4964.652474326798, 4972.2044472884345, 4930.235813448921, 4932.136876046696, 4963.60291176705, 4975.850724478271, 4984.850454486335, 4425.446819147606, 4438.0694397937, 4449.950545004031, 4465.106978604292, 4467.865964021084, 6086.239220097488, 6106.175666285084, 6121.224844795004, 6123.938760612381, 6149.200603921507, 5726.713664316768, 5758.884822303572, 5768.442520519437, 5774.249347584787, 5780.393058728815, 6458.483321334282, 6494.5453818232745, 6511.479081673502, 6559.311272316433, 6584.440322572587, 4838.612910967149, 4843.200871856139, 4862.343583616202, 4896.3389942358035, 4898.289747986558, 6660.70026848793, 6736.5958042517605, 6825.249222585511, 6845.691943862538, 6901.482388820808, 4954.331165292711, 4957.20684690455, 4959.380077490314, 4968.453470118284, 5018.89962200754, 5023.422306434733, 5065.316182315414, 5087.8473645789945, 5090.618203634742, 5093.770780314895, 5660.660360378391, 5698.800541981011, 5713.428657134254, 5730.856728581819, 5768.625039372428, 6549.836254093686, 6562.77030303937, 6590.868182636416, 6598.39363451434, 6609.9839548938035, 1764.2590112152927, 1767.76135221746, 1769.2480695704273, 1771.1675512509357, 1796.5508622844288, 1162.976740465186, 1218.0438355890583, 1228.6068458093325, 1232.6918270432393, 1251.0992085698283, 5754.510866576305, 5757.913631295534, 5771.8557036074435, 5780.797672081457, 5859.857327821034, 6452.935470645328, 6588.341165883469, 6696.86606267872, 6723.394894459424, 6770.255271920085, 5711.971440142773, 5730.512906402919, 5742.219911827347, 5788.3343415506915, 5808.128780682931, 3523.7709548879243, 3525.3301872644115, 3552.5967242938896, 3558.8576456941432, 3592.670711836637, 6494.188226471691, 6507.12153859223, 6546.770863019771, 6577.934220657732, 6602.438792702674, 6872.278410766898, 6938.653067346612, 6942.826429339307, 6973.232944376115, 7000.0, 6471.38521840415, 6489.1888513935755, 6529.706163222666, 6593.241777195588, 6598.901016484757, 6181.660008699565, 6601.603903765789, 6661.867482527885, 6725.798226053226, 6735.124433823572, 6542.967285163544, 6600.702968366339, 6606.042123892104, 6629.403353698191, 6659.067730517828, 6521.804345869631, 6532.902006470002, 6549.410553050248, 6562.5406221564035, 6566.8358291041195, 4959.743316790779, 4969.776360063878, 4986.15235409974, 4988.700677959189, 5031.144705400164, 6481.481481481376, 6502.479801615765, 6631.602103873783, 6691.5650482718465, 6771.458283337222, 6448.645784385331, 6463.482921366185, 6487.54587178893, 6510.8839627122325, 6550.181227346582, 6505.577137486048, 6508.479321654161, 6534.901976470452, 6535.869282614226, 6548.264709851988, 6516.0551719999385, 6538.771143009972, 6543.509236807164, 6568.868622627425, 6571.638559879252, 6677.465802735673, 6688.197416310074, 6691.799246022627, 6696.665166741546, 6709.295523970108, 6414.294427613052, 6463.903041454288, 6468.15913931186, 6482.837929051811, 6500.934990650033], "value": 5061.739878550016, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [904.0642934562729, 907.9818403631928, 925.5279807298284, 929.6839074714595, 932.2029664636735, 18794.90602546987, 19918.0, 19944.0, 19954.30159944402, 22127.668084978697, 22109.778902210972, 22715.886420567873, 22723.659145112837, 22791.0, 22979.0, 999.2805180270194, 1019.4036488654147, 1023.825949588568, 1024.4109636958742, 1024.9897501025007, 971.13568923658, 1020.7550187954912, 1033.1837848099992, 1033.881103673076, 1035.5857656937249, 1089.9945500272527, 1092.4264761000459, 1092.7322805912563, 1093.6664317383195, 1094.195766111907, 1068.0707784227693, 1073.726199819049, 1081.0540776820283, 1081.7241603391124, 1084.3981590217427, 777.8522080804629, 783.7100272899007, 783.9333656639193, 785.7053604898164, 787.350435890387, 20465.38603841887, 20473.4881627959, 20642.896785516128, 20794.16823327065, 20858.478538036517, 21799.78200218009, 22068.74509980173, 22190.667139992915, 22398.552028959493, 22534.09863605454, 16808.814854069016, 16820.74768878468, 16821.66356672872, 16951.91524042384, 17160.141992900306, 3686.8525258989607, 3693.8522459101605, 3716.591174970751, 3717.3866312058476, 3721.14413684854, 126587.36706316502, 128323.0, 129977.0, 129978.0, 131136.0, 17859.73210401845, 17911.641767164583, 18348.174332155086, 18407.079646017646, 18467.0, 31119.844400777853, 32174.0, 32174.0, 32330.676693232766, 32342.676573233966, 7714.9228507715325, 8068.757937261891, 9197.49413782235, 9312.8603070954, 9533.761655958519, 4356.128774245164, 4383.693141480129, 4397.780110994501, 4408.118376324748, 4412.183746006999, 5399.919001214985, 5435.374931882805, 5454.0, 5495.450454954473, 5506.229127922094, 1059.523214553454, 1078.5146683992234, 1089.4280502736126, 1091.4651820608003, 1097.5280629329466, 672.5930811858852, 674.6727836999052, 685.4139710547411, 698.8742026435291, 700.0339531446571, 11966.341851198094, 11969.521219151136, 12132.452185041064, 12450.190737602208, 13428.19430834153, 675.861448403086, 678.1895634716565, 691.0705101638289, 695.9199692035379, 722.7145277615313, 5958.404159584007, 5990.64056156632, 6074.574779765374, 6191.19514463117, 6216.875662486816, 105204.0, 106561.46719266509, 108346.0, 109142.0, 109362.0, 95188.0, 96624.51687741517, 98051.50974245225, 99140.0, 99250.50374748225, 84463.0, 84616.57691711502, 84929.0, 86352.56823715966, 88528.5573572128, 12794.488220471449, 13179.802302965272, 13290.800637990631, 13323.66690832737, 13433.462661493431, 38732.41901371425, 39104.21791564096, 39627.80186099051, 40310.596894030685, 40795.77612671625, 50046.499535004186, 50198.0, 50360.748196258784, 50394.244086338, 51694.48305516897, 18891.43325700231, 20664.380068597966, 20993.0, 21143.57712845765, 21387.144514219257, 23928.521429571658, 23997.760022399554, 24111.397215069763, 24236.666983315383, 24615.261542153763, 17759.0, 18523.44429667112, 18983.525411864815, 19494.31769888047, 20001.399958001282, 19697.901510492356, 19719.704204437232, 20046.699299510812, 20896.791032089484, 22008.669869952282, 19357.806421935602, 19367.0, 19513.512162196057, 20908.268210612554, 21170.0, 12831.422585983466, 13256.138351007154, 13453.46186152543, 13520.59438216855, 13758.380872860946, 12668.493260269486, 13146.145500542434, 13292.401841916944, 13512.0, 14925.776113358092], "value": 9427.984291264327, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1530.4000000000003, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 110.0, 102.0, 109.0, 108.0, 116.0, 111.0, 99.0, 110.0, 110.0], "value": 107.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 118.0, 140.0, 183.0, 123.0, 146.0, 143.0, 118.0, 179.0, 119.0], "value": 142.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 165.0, 163.0, 163.0, 163.0, 162.0, 166.0, 171.0, 166.0, 164.0], "value": 164.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 78.0, 181.0, 76.0, 75.0, 75.0, 74.0, 155.0, 75.0], "value": 94.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 79.0, 130.0, 82.0, 80.0, 80.0, 126.0, 82.0, 83.0, 129.0], "value": 95.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 115.0, 115.0, 116.0, 115.0, 115.0, 115.0, 115.0, 114.0, 115.0], "value": 115.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 154.0, 151.0, 151.0, 152.0, 152.0, 150.0, 151.0, 151.0, 152.0], "value": 151.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 94.0, 95.0, 94.0, 94.0, 95.0, 96.0, 95.0, 94.0], "value": 94.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 53.0, 54.0, 55.0, 56.0, 54.0, 54.0, 53.0, 54.0, 54.0], "value": 54.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 55.0, 55.0, 55.0, 55.0, 55.0, 56.0, 55.0, 55.0, 57.0], "value": 55.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 83.0, 76.0, 77.0, 76.0, 79.0, 76.0, 79.0, 77.0, 78.0], "value": 77.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 129.0, 131.0, 129.0, 117.0, 124.0, 121.0, 129.0, 123.0, 159.0], "value": 129.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [176.0, 176.0, 196.0, 191.0, 173.0, 173.0, 188.0, 178.0, 173.0, 175.0], "value": 179.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 67.0, 68.0, 69.0, 68.0, 72.0, 70.0, 71.0, 67.0, 66.0], "value": 68.7, "unit": "score"}]}]} 17:27:58 INFO - Return code: 0 17:27:58 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 17:27:58 INFO - # TBPL SUCCESS # 17:27:58 INFO - Running post-action listener: _package_coverage_data 17:27:58 INFO - Running post-action listener: _resource_record_post_action 17:27:58 INFO - [mozharness: 2017-08-18 00:27:58.809502Z] Finished run-tests step (success) 17:27:58 INFO - Running post-run listener: _resource_record_post_run 17:27:58 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 65536; Write bytes: 437751808; Read time: 280; Write time: 421900 17:27:58 INFO - TinderboxPrint: CPU usage
13.1% 17:27:58 INFO - TinderboxPrint: I/O read bytes / time
65,536 / 280 17:27:58 INFO - TinderboxPrint: I/O write bytes / time
437,751,808 / 421,900 17:27:58 INFO - TinderboxPrint: CPU idle
8,251.3 (86.8%) 17:27:58 INFO - TinderboxPrint: CPU user
1,198.2 (12.6%) 17:27:58 INFO - TinderboxPrint: Swap in / out
0 / 0 17:27:58 INFO - install - Wall time: 19s; CPU: 14.0%; Read bytes: 0; Write bytes: 110313472; Read time: 0; Write time: 158008 17:27:58 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 17:27:58 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 65536; Write bytes: 327438336; Read time: 280; Write time: 263892 17:27:59 INFO - Running post-run listener: _upload_blobber_files 17:27:59 INFO - Blob upload gear active. 17:27:59 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:27:59 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 17:27:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 17:27:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 17:27:59 INFO - (blobuploader) - INFO - Open directory for files ... 17:27:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 17:27:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:27:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:28:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 17:28:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:28:00 INFO - (blobuploader) - INFO - Done attempting. 17:28:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 17:28:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:28:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:28:01 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 17:28:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:28:01 INFO - (blobuploader) - INFO - Done attempting. 17:28:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 17:28:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:28:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:28:08 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 17:28:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:28:08 INFO - (blobuploader) - INFO - Done attempting. 17:28:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 17:28:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:28:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:28:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 17:28:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:28:09 INFO - (blobuploader) - INFO - Done attempting. 17:28:09 INFO - (blobuploader) - INFO - Iteration through files over. 17:28:09 INFO - Return code: 0 17:28:09 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:28:09 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:28:09 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ca9df7b8593caaa90dffb85bc3f0aca78969ea9de442fdea22322ca3697eec488b5decf9e48891e52e0fe50b7d29042a26f47c5f187964c684c8c21b664bb020", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/fa5ac0db85a39d83edd7d2b95b43b0c794240b2a83df026108429e41375ad0392e9b55e2a9080d04e726f7c198a48e291e4bb904ba64731cbddb091e3b5c1dd2", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2c0807b1da323cfb13d96ed55ee3591f9b1a6cc5dd7557fdd86f35d3e95e3a5c64dc79cfa79d4ccc37d73afb2e86e2b948c59190f966be5f914c703c4cfa959a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/53b98a671333489bf0da93672da92bcd63f3fe061feb8aafa64f90e6258a0e0550cf9b96a44037f0a2294e0decc3c029a0771eadbb97ab202ac01e37cae7a8e1"} 17:28:09 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:28:09 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:28:09 INFO - Contents: 17:28:09 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ca9df7b8593caaa90dffb85bc3f0aca78969ea9de442fdea22322ca3697eec488b5decf9e48891e52e0fe50b7d29042a26f47c5f187964c684c8c21b664bb020", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/fa5ac0db85a39d83edd7d2b95b43b0c794240b2a83df026108429e41375ad0392e9b55e2a9080d04e726f7c198a48e291e4bb904ba64731cbddb091e3b5c1dd2", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2c0807b1da323cfb13d96ed55ee3591f9b1a6cc5dd7557fdd86f35d3e95e3a5c64dc79cfa79d4ccc37d73afb2e86e2b948c59190f966be5f914c703c4cfa959a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/53b98a671333489bf0da93672da92bcd63f3fe061feb8aafa64f90e6258a0e0550cf9b96a44037f0a2294e0decc3c029a0771eadbb97ab202ac01e37cae7a8e1"} 17:28:09 INFO - Running post-run listener: copy_logs_to_upload_dir 17:28:09 INFO - Copying logs to upload dir... 17:28:09 INFO - mkdir: /builds/slave/test/build/upload/logs 17:28:09 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1253.819357 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2017-08-17 17:28:09.618013) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-17 17:28:09.621719) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1503014834.80210-986790238 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ca9df7b8593caaa90dffb85bc3f0aca78969ea9de442fdea22322ca3697eec488b5decf9e48891e52e0fe50b7d29042a26f47c5f187964c684c8c21b664bb020", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/fa5ac0db85a39d83edd7d2b95b43b0c794240b2a83df026108429e41375ad0392e9b55e2a9080d04e726f7c198a48e291e4bb904ba64731cbddb091e3b5c1dd2", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2c0807b1da323cfb13d96ed55ee3591f9b1a6cc5dd7557fdd86f35d3e95e3a5c64dc79cfa79d4ccc37d73afb2e86e2b948c59190f966be5f914c703c4cfa959a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/53b98a671333489bf0da93672da92bcd63f3fe061feb8aafa64f90e6258a0e0550cf9b96a44037f0a2294e0decc3c029a0771eadbb97ab202ac01e37cae7a8e1"} build_url:https://queue.taskcluster.net/v1/task/b0RIcHGxQVmCDF_P3NNDKg/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011216 build_url: 'https://queue.taskcluster.net/v1/task/b0RIcHGxQVmCDF_P3NNDKg/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ca9df7b8593caaa90dffb85bc3f0aca78969ea9de442fdea22322ca3697eec488b5decf9e48891e52e0fe50b7d29042a26f47c5f187964c684c8c21b664bb020", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/fa5ac0db85a39d83edd7d2b95b43b0c794240b2a83df026108429e41375ad0392e9b55e2a9080d04e726f7c198a48e291e4bb904ba64731cbddb091e3b5c1dd2", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2c0807b1da323cfb13d96ed55ee3591f9b1a6cc5dd7557fdd86f35d3e95e3a5c64dc79cfa79d4ccc37d73afb2e86e2b948c59190f966be5f914c703c4cfa959a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/53b98a671333489bf0da93672da92bcd63f3fe061feb8aafa64f90e6258a0e0550cf9b96a44037f0a2294e0decc3c029a0771eadbb97ab202ac01e37cae7a8e1"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-17 17:28:09.648721) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-17 17:28:09.649053) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1503014834.80210-986790238 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004573 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-17 17:28:09.736239) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-17 17:28:09.736788) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-17 17:28:09.737150) ========= ========= Total master_lag: 0.18 =========