builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-002 starttime: 1502028331.39 results: success (0) revision: fe6609d22dfdd710b11e3ac7773aff89f7a8d12c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-08-06 07:05:31.385846) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-08-06 07:05:31.392556) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-06 07:05:31.392865) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-06 07:05:31.422507) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-06 07:05:31.422779) ========= 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=a0d2d2de893abaa8702a9954000001a7-1502016693.72581-2051344785 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-08-06 07:05:31-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 42.6M=0s 2017-08-06 07:05:31 (42.6 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.092538 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-06 07:05:31.528863) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-06 07:05:31.532195) ========= 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=a0d2d2de893abaa8702a9954000001a7-1502016693.72581-2051344785 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015146 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-06 07:05:31.581990) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-06 07:05:31.582314) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev fe6609d22dfdd710b11e3ac7773aff89f7a8d12c --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 fe6609d22dfdd710b11e3ac7773aff89f7a8d12c --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=a0d2d2de893abaa8702a9954000001a7-1502016693.72581-2051344785 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-08-06 07:05:31,684 truncating revision to first 12 chars 2017-08-06 07:05:31,684 Setting DEBUG logging. 2017-08-06 07:05:31,684 attempt 1/10 2017-08-06 07:05:31,684 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/fe6609d22dfd?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-08-06 07:05:32,157 unpacking tar archive at: mozilla-central-fe6609d22dfd/testing/mozharness/ program finished with exit code 0 elapsedTime=0.863733 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-06 07:05:32.461815) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-06 07:05:32.465112) ========= script_repo_revision: fe6609d22dfdd710b11e3ac7773aff89f7a8d12c ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-06 07:05:32.465478) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-06 07:05:32.465750) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-06 07:05:32.478849) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 51 secs) (at 2017-08-06 07:05:32.479133) ========= /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=a0d2d2de893abaa8702a9954000001a7-1502016693.72581-2051344785 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:05:32 INFO - MultiFileLogger online at 20170806 07:05:32 in /builds/slave/test 07:05:32 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 07:05:32 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:05:32 INFO - {'append_to_log': False, 07:05:32 INFO - 'base_work_dir': '/builds/slave/test', 07:05:32 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 07:05:32 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:05:32 INFO - 'branch': 'Firefox-Non-PGO', 07:05:32 INFO - 'buildbot_json_path': 'buildprops.json', 07:05:32 INFO - 'code_coverage': False, 07:05:32 INFO - 'config_files': ('talos/linux_config.py',), 07:05:32 INFO - 'default_actions': ('clobber', 07:05:32 INFO - 'read-buildbot-config', 07:05:32 INFO - 'download-and-extract', 07:05:32 INFO - 'populate-webroot', 07:05:32 INFO - 'create-virtualenv', 07:05:32 INFO - 'install', 07:05:32 INFO - 'setup-mitmproxy', 07:05:32 INFO - 'run-tests'), 07:05:32 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:05:32 INFO - 'disable_ccov_upload': False, 07:05:32 INFO - 'download_minidump_stackwalk': True, 07:05:32 INFO - 'download_symbols': 'ondemand', 07:05:32 INFO - 'enable_stylo': False, 07:05:32 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:05:32 INFO - 'tooltool.py': '/tools/tooltool.py', 07:05:32 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:05:32 INFO - '/tools/misc-python/virtualenv.py')}, 07:05:32 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:05:32 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:05:32 INFO - 'gecko_profile': False, 07:05:32 INFO - 'gecko_profile_interval': 0, 07:05:32 INFO - 'installer_path': 'installer.exe', 07:05:32 INFO - 'log_level': 'info', 07:05:32 INFO - 'log_name': 'talos', 07:05:32 INFO - 'log_to_console': True, 07:05:32 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:05:32 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:05:32 INFO - 'opt_config_files': (), 07:05:32 INFO - 'pip_index': False, 07:05:32 INFO - 'suite': 'dromaeojs-e10s', 07:05:32 INFO - 'system_bits': '32', 07:05:32 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:05:32 INFO - 'title': 'talos-linux64-ix-002', 07:05:32 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:05:32 INFO - 'use_talos_json': True, 07:05:32 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:05:32 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:05:32 INFO - 'work_dir': 'build'} 07:05:32 INFO - [mozharness: 2017-08-06 14:05:32.688789Z] Running clobber step. 07:05:32 INFO - Running pre-action listener: _resource_record_pre_action 07:05:32 INFO - Running main action method: clobber 07:05:32 INFO - rmtree: /builds/slave/test/build 07:05:32 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:05:34 INFO - Running post-action listener: _resource_record_post_action 07:05:34 INFO - [mozharness: 2017-08-06 14:05:34.239775Z] Finished clobber step (success) 07:05:34 INFO - [mozharness: 2017-08-06 14:05:34.239876Z] Running read-buildbot-config step. 07:05:34 INFO - Running pre-action listener: _resource_record_pre_action 07:05:34 INFO - Running main action method: read_buildbot_config 07:05:34 INFO - Using buildbot properties: 07:05:34 INFO - { 07:05:34 INFO - "project": "", 07:05:34 INFO - "product": "firefox", 07:05:34 INFO - "who": "archaeopteryx@coole-files.de", 07:05:34 INFO - "installer_path": "public/build/target.tar.bz2", 07:05:34 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 07:05:34 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 07:05:34 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 07:05:34 INFO - "stage_platform": "linux64", 07:05:34 INFO - "basedir": "/builds/slave/test", 07:05:34 INFO - "buildnumber": 757, 07:05:34 INFO - "platform": "ubuntu64_hw", 07:05:34 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 07:05:34 INFO - "slavebuilddir": "test", 07:05:34 INFO - "taskId": "DpgidOYARVOZFGyK2-5FwA", 07:05:34 INFO - "branch": "mozilla-central", 07:05:34 INFO - "script_repo_revision": "production", 07:05:34 INFO - "revision": "fe6609d22dfdd710b11e3ac7773aff89f7a8d12c", 07:05:34 INFO - "slavename": "talos-linux64-ix-002", 07:05:34 INFO - "repo_path": "mozilla-central" 07:05:34 INFO - } 07:05:34 INFO - Finding installer, test and symbols from parent task. 07:05:34 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/DpgidOYARVOZFGyK2-5FwA'}, attempt #1 07:05:34 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/DpgidOYARVOZFGyK2-5FwA'}, attempt #1 07:05:35 INFO - Task dependencies: Ph1H-2ZlRnGCNKdcz7C8dw 07:05:35 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Ph1H-2ZlRnGCNKdcz7C8dw'}, attempt #1 07:05:35 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/Ph1H-2ZlRnGCNKdcz7C8dw/artifacts/public/build/target.tar.bz2 07:05:35 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/Ph1H-2ZlRnGCNKdcz7C8dw/artifacts/public/build/target.test_packages.json 07:05:35 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/Ph1H-2ZlRnGCNKdcz7C8dw/artifacts/public/build/target.crashreporter-symbols.zip 07:05:35 INFO - Running post-action listener: _resource_record_post_action 07:05:35 INFO - [mozharness: 2017-08-06 14:05:35.668881Z] Finished read-buildbot-config step (success) 07:05:35 INFO - [mozharness: 2017-08-06 14:05:35.669103Z] Running download-and-extract step. 07:05:35 INFO - Running pre-action listener: _resource_record_pre_action 07:05:35 INFO - Running main action method: download_and_extract 07:05:35 INFO - mkdir: /builds/slave/test/build/tests 07:05:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:05:35 INFO - trying https://queue.taskcluster.net/v1/task/Ph1H-2ZlRnGCNKdcz7C8dw/artifacts/public/build/target.test_packages.json 07:05:35 INFO - Downloading https://queue.taskcluster.net/v1/task/Ph1H-2ZlRnGCNKdcz7C8dw/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 07:05:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Ph1H-2ZlRnGCNKdcz7C8dw/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 07:05:36 INFO - Downloaded 989 bytes. 07:05:36 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 07:05:36 INFO - Using the following test package requirements: 07:05:36 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 07:05:36 INFO - u'common': [u'target.common.tests.zip'], 07:05:36 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 07:05:36 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 07:05:36 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 07:05:36 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 07:05:36 INFO - u'mozbase': [u'target.common.tests.zip'], 07:05:36 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 07:05:36 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 07:05:36 INFO - u'web-platform': [u'target.common.tests.zip', 07:05:36 INFO - u'target.web-platform.tests.tar.gz'], 07:05:36 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 07:05:36 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 07:05:36 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Ph1H-2ZlRnGCNKdcz7C8dw/artifacts/public/build/target.common.tests.zip 07:05:36 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Ph1H-2ZlRnGCNKdcz7C8dw/artifacts/public/build/target.common.tests.zip'}, attempt #1 07:05:36 INFO - Fetch https://queue.taskcluster.net/v1/task/Ph1H-2ZlRnGCNKdcz7C8dw/artifacts/public/build/target.common.tests.zip into memory 07:05:37 INFO - Content-Length response header: 54284831 07:05:37 INFO - Bytes received: 54284831 07:05:48 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 07:05:48 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Ph1H-2ZlRnGCNKdcz7C8dw/artifacts/public/build/target.common.tests.zip 07:05:48 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Ph1H-2ZlRnGCNKdcz7C8dw/artifacts/public/build/target.common.tests.zip'}, attempt #1 07:05:48 INFO - Fetch https://queue.taskcluster.net/v1/task/Ph1H-2ZlRnGCNKdcz7C8dw/artifacts/public/build/target.common.tests.zip into memory 07:05:49 INFO - Content-Length response header: 54284831 07:05:49 INFO - Bytes received: 54284831 07:06:01 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Ph1H-2ZlRnGCNKdcz7C8dw/artifacts/public/build/target.talos.tests.zip 07:06:01 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Ph1H-2ZlRnGCNKdcz7C8dw/artifacts/public/build/target.talos.tests.zip'}, attempt #1 07:06:01 INFO - Fetch https://queue.taskcluster.net/v1/task/Ph1H-2ZlRnGCNKdcz7C8dw/artifacts/public/build/target.talos.tests.zip into memory 07:06:02 INFO - Content-Length response header: 14496008 07:06:02 INFO - Bytes received: 14496008 07:06:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:06:02 INFO - trying https://queue.taskcluster.net/v1/task/Ph1H-2ZlRnGCNKdcz7C8dw/artifacts/public/build/target.tar.bz2 07:06:02 INFO - Downloading https://queue.taskcluster.net/v1/task/Ph1H-2ZlRnGCNKdcz7C8dw/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 07:06:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Ph1H-2ZlRnGCNKdcz7C8dw/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 07:06:03 INFO - Downloaded 61880648 bytes. 07:06:03 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Ph1H-2ZlRnGCNKdcz7C8dw/artifacts/public/build/target.tar.bz2 07:06:03 INFO - mkdir: /builds/slave/test/properties 07:06:03 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:06:03 INFO - Writing to file /builds/slave/test/properties/build_url 07:06:03 INFO - Contents: 07:06:03 INFO - build_url:https://queue.taskcluster.net/v1/task/Ph1H-2ZlRnGCNKdcz7C8dw/artifacts/public/build/target.tar.bz2 07:06:03 INFO - Running post-action listener: _resource_record_post_action 07:06:03 INFO - Running post-action listener: set_extra_try_arguments 07:06:03 INFO - [mozharness: 2017-08-06 14:06:03.688959Z] Finished download-and-extract step (success) 07:06:03 INFO - [mozharness: 2017-08-06 14:06:03.689057Z] Running populate-webroot step. 07:06:03 INFO - Running pre-action listener: _resource_record_pre_action 07:06:03 INFO - Running main action method: populate_webroot 07:06:03 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:06:03 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:06:03 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 07:06:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:06:03 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 07:06:03 INFO - 'tests': ['damp', 'tps']}, 07:06:03 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:06:03 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 07:06:03 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 07:06:03 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 07:06:03 INFO - 'other-e10s': {'tests': ['a11yr', 07:06:03 INFO - 'ts_paint', 07:06:03 INFO - 'tpaint', 07:06:03 INFO - 'sessionrestore', 07:06:03 INFO - 'sessionrestore_many_windows', 07:06:03 INFO - 'sessionrestore_no_auto_restore', 07:06:03 INFO - 'tabpaint']}, 07:06:03 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 07:06:03 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 07:06:03 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:06:03 INFO - 'tsvgr_opacity', 07:06:03 INFO - 'tart', 07:06:03 INFO - 'tscrollx', 07:06:03 INFO - 'tsvg_static']}, 07:06:03 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 07:06:03 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 07:06:03 INFO - 'talos_options': ['--mitmproxy', 07:06:03 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 07:06:03 INFO - '--firstNonBlankPaint'], 07:06:03 INFO - 'tests': ['tp6_google', 07:06:03 INFO - 'tp6_youtube', 07:06:03 INFO - 'tp6_amazon', 07:06:03 INFO - 'tp6_facebook']}, 07:06:03 INFO - 'tp6-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 07:06:03 INFO - 'talos_options': ['--stylo', 07:06:03 INFO - '--mitmproxy', 07:06:03 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 07:06:03 INFO - '--firstNonBlankPaint'], 07:06:03 INFO - 'tests': ['tp6_google', 07:06:03 INFO - 'tp6_youtube', 07:06:03 INFO - 'tp6_amazon', 07:06:03 INFO - 'tp6_facebook']}, 07:06:03 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 07:06:03 INFO - 'talos_options': ['--stylo', 07:06:03 INFO - '--stylo-threads=1', 07:06:03 INFO - '--mitmproxy', 07:06:03 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 07:06:03 INFO - '--firstNonBlankPaint'], 07:06:03 INFO - 'tests': ['tp6_google', 07:06:03 INFO - 'tp6_youtube', 07:06:03 INFO - 'tp6_amazon', 07:06:03 INFO - 'tp6_facebook']}, 07:06:03 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 07:06:03 INFO - 'talos_options': ['--xperf_path', 07:06:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:06:03 INFO - 'tests': ['tp5n']}}} 07:06:03 INFO - Running post-action listener: _resource_record_post_action 07:06:03 INFO - [mozharness: 2017-08-06 14:06:03.697480Z] Finished populate-webroot step (success) 07:06:03 INFO - [mozharness: 2017-08-06 14:06:03.697570Z] Running create-virtualenv step. 07:06:03 INFO - Running pre-action listener: _resource_record_pre_action 07:06:03 INFO - Running main action method: create_virtualenv 07:06:03 INFO - Creating virtualenv /builds/slave/test/build/venv 07:06:03 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 07:06:03 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:06:03 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 07:06:03 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:06:03 INFO - Using real prefix '/usr' 07:06:03 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:06:04 INFO - Installing distribute.............................................................................................................................................................................................done. 07:06:06 INFO - Installing pip.................done. 07:06:06 INFO - Return code: 0 07:06:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 07:06:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 07:06:06 INFO - Reading from file tmpfile_stdout 07:06:06 INFO - Output received: 07:06:06 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) 07:06:06 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:06: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')]} 07:06:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:06: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')]} 07:06:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:06: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1df91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fc6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2169d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2166eb0>, '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 0x2167db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2168240>, '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': 'a0d2d2de893abaa8702a9954000001a7-1502016693.72581-2051344785', '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 07:06: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', 'pip>=1.5'] in /builds/slave/test/build 07:06: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 pip>=1.5 07:06:06 INFO - Using env: {'DISPLAY': ':0', 07:06:06 INFO - 'HOME': '/home/cltbld', 07:06:06 INFO - 'LANG': 'en_US.UTF-8', 07:06:06 INFO - 'LANGUAGE': 'en_US:en', 07:06:06 INFO - 'LOGNAME': 'cltbld', 07:06:06 INFO - 'MAIL': '/var/mail/cltbld', 07:06:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:06:06 INFO - 'MOZ_NO_REMOTE': '1', 07:06:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:06:06 INFO - 'NO_EM_RESTART': '1', 07:06:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:06:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:06:06 INFO - 'PWD': '/builds/slave/test', 07:06:06 INFO - 'SHELL': '/bin/bash', 07:06:06 INFO - 'SHLVL': '1', 07:06:06 INFO - 'TERM': 'linux', 07:06:06 INFO - 'TMOUT': '86400', 07:06:06 INFO - 'USER': 'cltbld', 07:06:06 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1502016693.72581-2051344785', 07:06:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:06:06 INFO - '_': '/tools/buildbot/bin/python'} 07:06:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:06:06 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 07:06:06 INFO - Cleaning up... 07:06:06 INFO - Return code: 0 07:06:06 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:06: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')]} 07:06:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:06: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')]} 07:06:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:06: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', '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 0x1df91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fc6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2169d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2166eb0>, '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 0x2167db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2168240>, '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': 'a0d2d2de893abaa8702a9954000001a7-1502016693.72581-2051344785', '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 07:06: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', 'psutil>=3.1.1'] in /builds/slave/test/build 07:06: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 psutil>=3.1.1 07:06:06 INFO - Using env: {'DISPLAY': ':0', 07:06:06 INFO - 'HOME': '/home/cltbld', 07:06:06 INFO - 'LANG': 'en_US.UTF-8', 07:06:06 INFO - 'LANGUAGE': 'en_US:en', 07:06:06 INFO - 'LOGNAME': 'cltbld', 07:06:06 INFO - 'MAIL': '/var/mail/cltbld', 07:06:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:06:06 INFO - 'MOZ_NO_REMOTE': '1', 07:06:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:06:06 INFO - 'NO_EM_RESTART': '1', 07:06:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:06:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:06:06 INFO - 'PWD': '/builds/slave/test', 07:06:06 INFO - 'SHELL': '/bin/bash', 07:06:06 INFO - 'SHLVL': '1', 07:06:06 INFO - 'TERM': 'linux', 07:06:06 INFO - 'TMOUT': '86400', 07:06:06 INFO - 'USER': 'cltbld', 07:06:06 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1502016693.72581-2051344785', 07:06:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:06:06 INFO - '_': '/tools/buildbot/bin/python'} 07:06:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:06:06 INFO - Downloading/unpacking psutil>=3.1.1 07:06:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:06:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:06:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:06:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:06:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:06:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:06:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:06:08 INFO - Installing collected packages: psutil 07:06:08 INFO - Running setup.py install for psutil 07:06:08 INFO - building 'psutil._psutil_linux' extension 07:06:08 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 07:06:08 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 07:06:08 INFO - building 'psutil._psutil_posix' extension 07:06:08 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 07:06:08 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 07:06:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:06:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:06:08 INFO - Successfully installed psutil 07:06:08 INFO - Cleaning up... 07:06:08 INFO - Return code: 0 07:06:08 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:06:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:06:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:06:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:06:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:06:08 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 0x1df91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fc6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2169d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2166eb0>, '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 0x2167db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2168240>, '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': 'a0d2d2de893abaa8702a9954000001a7-1502016693.72581-2051344785', '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 07:06:08 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 07:06:08 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 07:06:08 INFO - Using env: {'DISPLAY': ':0', 07:06:08 INFO - 'HOME': '/home/cltbld', 07:06:08 INFO - 'LANG': 'en_US.UTF-8', 07:06:08 INFO - 'LANGUAGE': 'en_US:en', 07:06:08 INFO - 'LOGNAME': 'cltbld', 07:06:08 INFO - 'MAIL': '/var/mail/cltbld', 07:06:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:06:08 INFO - 'MOZ_NO_REMOTE': '1', 07:06:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:06:08 INFO - 'NO_EM_RESTART': '1', 07:06:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:06:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:06:08 INFO - 'PWD': '/builds/slave/test', 07:06:08 INFO - 'SHELL': '/bin/bash', 07:06:08 INFO - 'SHLVL': '1', 07:06:08 INFO - 'TERM': 'linux', 07:06:08 INFO - 'TMOUT': '86400', 07:06:08 INFO - 'USER': 'cltbld', 07:06:08 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1502016693.72581-2051344785', 07:06:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:06:08 INFO - '_': '/tools/buildbot/bin/python'} 07:06:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:06:08 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:06:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:06:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:06:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:06:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:06:09 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:06:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:06:10 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:06:10 INFO - Installing collected packages: mozsystemmonitor 07:06:10 INFO - Running setup.py install for mozsystemmonitor 07:06:10 INFO - Successfully installed mozsystemmonitor 07:06:10 INFO - Cleaning up... 07:06:10 INFO - Return code: 0 07:06:10 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:06:10 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')]} 07:06:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:06:10 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')]} 07:06:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:06:10 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 0x1df91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fc6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2169d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2166eb0>, '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 0x2167db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2168240>, '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': 'a0d2d2de893abaa8702a9954000001a7-1502016693.72581-2051344785', '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 07:06:10 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 07:06:10 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 07:06:10 INFO - Using env: {'DISPLAY': ':0', 07:06:10 INFO - 'HOME': '/home/cltbld', 07:06:10 INFO - 'LANG': 'en_US.UTF-8', 07:06:10 INFO - 'LANGUAGE': 'en_US:en', 07:06:10 INFO - 'LOGNAME': 'cltbld', 07:06:10 INFO - 'MAIL': '/var/mail/cltbld', 07:06:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:06:10 INFO - 'MOZ_NO_REMOTE': '1', 07:06:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:06:10 INFO - 'NO_EM_RESTART': '1', 07:06:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:06:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:06:10 INFO - 'PWD': '/builds/slave/test', 07:06:10 INFO - 'SHELL': '/bin/bash', 07:06:10 INFO - 'SHLVL': '1', 07:06:10 INFO - 'TERM': 'linux', 07:06:10 INFO - 'TMOUT': '86400', 07:06:10 INFO - 'USER': 'cltbld', 07:06:10 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1502016693.72581-2051344785', 07:06:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:06:10 INFO - '_': '/tools/buildbot/bin/python'} 07:06:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:06:10 INFO - Downloading/unpacking jsonschema==2.5.1 07:06:10 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 07:06:10 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 07:06:10 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 07:06:10 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 07:06:11 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:06:11 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:06:11 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 07:06:11 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 07:06:11 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 07:06:11 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 07:06:11 INFO - Downloading functools32-3.2.3-2.tar.gz 07:06:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:06:11 INFO - warning: no files found matching '*.txt' 07:06:11 INFO - no previously-included directories found matching 'build' 07:06:11 INFO - no previously-included directories found matching 'dist' 07:06:11 INFO - no previously-included directories found matching '.git*' 07:06:11 INFO - Installing collected packages: jsonschema, functools32 07:06:11 INFO - Running setup.py install for functools32 07:06:11 INFO - warning: no files found matching '*.txt' 07:06:11 INFO - no previously-included directories found matching 'build' 07:06:11 INFO - no previously-included directories found matching 'dist' 07:06:11 INFO - no previously-included directories found matching '.git*' 07:06:11 INFO - Successfully installed jsonschema functools32 07:06:11 INFO - Cleaning up... 07:06:11 INFO - Return code: 0 07:06:11 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 07:06:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:06:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:06:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:06:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:06:11 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 0x1df91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fc6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2169d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2166eb0>, '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 0x2167db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2168240>, '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': 'a0d2d2de893abaa8702a9954000001a7-1502016693.72581-2051344785', '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 07:06:11 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 07:06:11 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 07:06:11 INFO - Using env: {'DISPLAY': ':0', 07:06:11 INFO - 'HOME': '/home/cltbld', 07:06:11 INFO - 'LANG': 'en_US.UTF-8', 07:06:11 INFO - 'LANGUAGE': 'en_US:en', 07:06:11 INFO - 'LOGNAME': 'cltbld', 07:06:11 INFO - 'MAIL': '/var/mail/cltbld', 07:06:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:06:11 INFO - 'MOZ_NO_REMOTE': '1', 07:06:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:06:11 INFO - 'NO_EM_RESTART': '1', 07:06:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:06:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:06:11 INFO - 'PWD': '/builds/slave/test', 07:06:11 INFO - 'SHELL': '/bin/bash', 07:06:11 INFO - 'SHLVL': '1', 07:06:11 INFO - 'TERM': 'linux', 07:06:11 INFO - 'TMOUT': '86400', 07:06:11 INFO - 'USER': 'cltbld', 07:06:11 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1502016693.72581-2051344785', 07:06:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:06:11 INFO - '_': '/tools/buildbot/bin/python'} 07:06:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:06:12 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 07:06:12 INFO - Cleaning up... 07:06:12 INFO - Return code: 0 07:06:12 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:06:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:06:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:06:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:06:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:06:12 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 0x1df91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fc6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2169d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2166eb0>, '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 0x2167db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2168240>, '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': 'a0d2d2de893abaa8702a9954000001a7-1502016693.72581-2051344785', '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 07:06:12 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 07:06:12 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 07:06:12 INFO - Using env: {'DISPLAY': ':0', 07:06:12 INFO - 'HOME': '/home/cltbld', 07:06:12 INFO - 'LANG': 'en_US.UTF-8', 07:06:12 INFO - 'LANGUAGE': 'en_US:en', 07:06:12 INFO - 'LOGNAME': 'cltbld', 07:06:12 INFO - 'MAIL': '/var/mail/cltbld', 07:06:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:06:12 INFO - 'MOZ_NO_REMOTE': '1', 07:06:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:06:12 INFO - 'NO_EM_RESTART': '1', 07:06:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:06:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:06:12 INFO - 'PWD': '/builds/slave/test', 07:06:12 INFO - 'SHELL': '/bin/bash', 07:06:12 INFO - 'SHLVL': '1', 07:06:12 INFO - 'TERM': 'linux', 07:06:12 INFO - 'TMOUT': '86400', 07:06:12 INFO - 'USER': 'cltbld', 07:06:12 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1502016693.72581-2051344785', 07:06:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:06:12 INFO - '_': '/tools/buildbot/bin/python'} 07:06:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:06:12 INFO - Downloading/unpacking blobuploader==1.2.4 07:06:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:06:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:06:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:06:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:06:13 INFO - Downloading blobuploader-1.2.4.tar.gz 07:06:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:06:13 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:06:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:06:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:06:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:06:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:06:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:06:13 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:06:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:06:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:06:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:06:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:06:13 INFO - Downloading docopt-0.6.1.tar.gz 07:06:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:06:14 INFO - Installing collected packages: blobuploader, requests, docopt 07:06:14 INFO - Running setup.py install for blobuploader 07:06:14 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:06:14 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:06:14 INFO - Running setup.py install for requests 07:06:14 INFO - Running setup.py install for docopt 07:06:14 INFO - Successfully installed blobuploader requests docopt 07:06:14 INFO - Cleaning up... 07:06:14 INFO - Return code: 0 07:06:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:06:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:06:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:06:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:06:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:06:14 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 0x1df91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fc6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2169d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2166eb0>, '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 0x2167db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2168240>, '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': 'a0d2d2de893abaa8702a9954000001a7-1502016693.72581-2051344785', '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 07:06:14 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 07:06:14 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 07:06:14 INFO - Using env: {'DISPLAY': ':0', 07:06:14 INFO - 'HOME': '/home/cltbld', 07:06:14 INFO - 'LANG': 'en_US.UTF-8', 07:06:14 INFO - 'LANGUAGE': 'en_US:en', 07:06:14 INFO - 'LOGNAME': 'cltbld', 07:06:14 INFO - 'MAIL': '/var/mail/cltbld', 07:06:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:06:14 INFO - 'MOZ_NO_REMOTE': '1', 07:06:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:06:14 INFO - 'NO_EM_RESTART': '1', 07:06:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:06:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:06:14 INFO - 'PWD': '/builds/slave/test', 07:06:14 INFO - 'SHELL': '/bin/bash', 07:06:14 INFO - 'SHLVL': '1', 07:06:14 INFO - 'TERM': 'linux', 07:06:14 INFO - 'TMOUT': '86400', 07:06:14 INFO - 'USER': 'cltbld', 07:06:14 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1502016693.72581-2051344785', 07:06:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:06:14 INFO - '_': '/tools/buildbot/bin/python'} 07:06:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:06:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:06:14 INFO - Running setup.py (path:/tmp/pip-hgNSds-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:06:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:06:14 INFO - Running setup.py (path:/tmp/pip-_LsAkt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:06:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:06:15 INFO - Running setup.py (path:/tmp/pip-ZnapgC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:06:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:06:15 INFO - Running setup.py (path:/tmp/pip-R4TTxK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:06:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:06:15 INFO - Running setup.py (path:/tmp/pip-7XPJJR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:06:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:06:15 INFO - Running setup.py (path:/tmp/pip-E3AG0X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:06:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:06:15 INFO - Running setup.py (path:/tmp/pip-XAagCi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:06:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:06:15 INFO - Running setup.py (path:/tmp/pip-aHK0Rk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:06:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:06:15 INFO - Running setup.py (path:/tmp/pip-knspdt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:06:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:06:15 INFO - Running setup.py (path:/tmp/pip-Sx0jFy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:06:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:06:15 INFO - Running setup.py (path:/tmp/pip-3Pn3pP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:06:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:06:15 INFO - Running setup.py (path:/tmp/pip-PV_cTR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:06:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:06:15 INFO - Running setup.py (path:/tmp/pip-IHOxVx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:06:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:06:15 INFO - Running setup.py (path:/tmp/pip-1cwsiB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:06:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:06:15 INFO - Running setup.py (path:/tmp/pip-4MlMxT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:06:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:06:15 INFO - Running setup.py (path:/tmp/pip-i1MfOb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:06:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:06:16 INFO - Running setup.py (path:/tmp/pip-nCtqbR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:06:16 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:06:16 INFO - Running setup.py install for manifestparser 07:06:16 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:06:16 INFO - Running setup.py install for mozcrash 07:06:16 INFO - Running setup.py install for mozdebug 07:06:16 INFO - Running setup.py install for mozdevice 07:06:16 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:06:16 INFO - Running setup.py install for mozfile 07:06:16 INFO - Running setup.py install for mozhttpd 07:06:16 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:06:16 INFO - Running setup.py install for mozinfo 07:06:16 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:06:16 INFO - Running setup.py install for mozInstall 07:06:16 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:06:16 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:06:16 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:06:16 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:06:16 INFO - Running setup.py install for mozleak 07:06:16 INFO - Running setup.py install for mozlog 07:06:17 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:06:17 INFO - Running setup.py install for moznetwork 07:06:17 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:06:17 INFO - Running setup.py install for mozprocess 07:06:17 INFO - Running setup.py install for mozprofile 07:06:17 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:06:17 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:06:17 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:06:17 INFO - Running setup.py install for mozrunner 07:06:17 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:06:17 INFO - Running setup.py install for mozscreenshot 07:06:17 INFO - Running setup.py install for moztest 07:06:17 INFO - Running setup.py install for mozversion 07:06:17 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:06:17 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:06:17 INFO - Cleaning up... 07:06:17 INFO - Return code: 0 07:06:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:06:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:06:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:06:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:06:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:06:17 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 0x1df91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fc6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2169d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2166eb0>, '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 0x2167db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2168240>, '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': 'a0d2d2de893abaa8702a9954000001a7-1502016693.72581-2051344785', '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 07:06:17 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 07:06:17 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 07:06:17 INFO - Using env: {'DISPLAY': ':0', 07:06:17 INFO - 'HOME': '/home/cltbld', 07:06:17 INFO - 'LANG': 'en_US.UTF-8', 07:06:17 INFO - 'LANGUAGE': 'en_US:en', 07:06:17 INFO - 'LOGNAME': 'cltbld', 07:06:17 INFO - 'MAIL': '/var/mail/cltbld', 07:06:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:06:17 INFO - 'MOZ_NO_REMOTE': '1', 07:06:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:06:17 INFO - 'NO_EM_RESTART': '1', 07:06:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:06:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:06:17 INFO - 'PWD': '/builds/slave/test', 07:06:17 INFO - 'SHELL': '/bin/bash', 07:06:17 INFO - 'SHLVL': '1', 07:06:17 INFO - 'TERM': 'linux', 07:06:17 INFO - 'TMOUT': '86400', 07:06:17 INFO - 'USER': 'cltbld', 07:06:17 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1502016693.72581-2051344785', 07:06:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:06:17 INFO - '_': '/tools/buildbot/bin/python'} 07:06:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:06:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:06:18 INFO - Running setup.py (path:/tmp/pip-FQMVc3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:06:18 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)) 07:06:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:06:18 INFO - Running setup.py (path:/tmp/pip-wUu7rh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:06:18 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)) 07:06:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:06:18 INFO - Running setup.py (path:/tmp/pip-8vZoTp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:06:18 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)) 07:06:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:06:18 INFO - Running setup.py (path:/tmp/pip-qxkYbE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:06:18 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)) 07:06:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:06:18 INFO - Running setup.py (path:/tmp/pip-mIx0c8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:06:18 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)) 07:06:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:06:18 INFO - Running setup.py (path:/tmp/pip-BW_jSY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:06:18 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)) 07:06:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:06:18 INFO - Running setup.py (path:/tmp/pip-2BsMQm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:06:18 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)) 07:06:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:06:18 INFO - Running setup.py (path:/tmp/pip-w2BMM5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:06:18 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)) 07:06:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:06:18 INFO - Running setup.py (path:/tmp/pip-0IyNqq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:06:18 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)) 07:06:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:06:18 INFO - Running setup.py (path:/tmp/pip-Civgiq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:06:18 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)) 07:06:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:06:18 INFO - Running setup.py (path:/tmp/pip-XU9tZm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:06:18 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)) 07:06:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:06:18 INFO - Running setup.py (path:/tmp/pip-HacsHG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:06:18 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)) 07:06:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:06:18 INFO - Running setup.py (path:/tmp/pip-XQrixa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:06:19 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)) 07:06:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:06:19 INFO - Running setup.py (path:/tmp/pip-AO1wfx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:06:19 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)) 07:06:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:06:19 INFO - Running setup.py (path:/tmp/pip-3Yjhcy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:06:19 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)) 07:06:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:06:19 INFO - Running setup.py (path:/tmp/pip-EgEJ3i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:06:19 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)) 07:06:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:06:19 INFO - Running setup.py (path:/tmp/pip-zb3zLt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:06:19 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)) 07:06:19 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)) 07:06:19 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)) 07:06:19 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)) 07:06:19 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)) 07:06:19 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)) 07:06:19 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)) 07:06:19 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:06:19 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 07:06:19 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 07:06:19 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 07:06:19 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 07:06:20 INFO - Downloading blessings-1.6.tar.gz 07:06:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:06:20 INFO - Installing collected packages: blessings 07:06:20 INFO - Running setup.py install for blessings 07:06:20 INFO - Successfully installed blessings 07:06:20 INFO - Cleaning up... 07:06:20 INFO - Return code: 0 07:06:20 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:06:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:06:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:06:20 INFO - Reading from file tmpfile_stdout 07:06:20 INFO - Current package versions: 07:06:20 INFO - argparse == 1.2.1 07:06:20 INFO - blessings == 1.6 07:06:20 INFO - blobuploader == 1.2.4 07:06:20 INFO - docopt == 0.6.1 07:06:20 INFO - functools32 == 3.2.3-2 07:06:20 INFO - jsonschema == 2.5.1 07:06:20 INFO - manifestparser == 1.1 07:06:20 INFO - mozInstall == 1.13 07:06:20 INFO - mozcrash == 1.0 07:06:20 INFO - mozdebug == 0.1 07:06:20 INFO - mozdevice == 0.51 07:06:20 INFO - mozfile == 1.2 07:06:20 INFO - mozhttpd == 0.7 07:06:20 INFO - mozinfo == 0.10 07:06:20 INFO - mozleak == 0.1 07:06:20 INFO - mozlog == 3.5 07:06:20 INFO - moznetwork == 0.27 07:06:20 INFO - mozprocess == 0.25 07:06:20 INFO - mozprofile == 0.28 07:06:20 INFO - mozrunner == 6.13 07:06:20 INFO - mozscreenshot == 0.1 07:06:20 INFO - mozsystemmonitor == 0.3 07:06:20 INFO - moztest == 0.8 07:06:20 INFO - mozversion == 1.4 07:06:20 INFO - psutil == 3.1.1 07:06:20 INFO - requests == 1.2.3 07:06:20 INFO - wsgiref == 0.1.2 07:06:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:06:20 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')]} 07:06:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:06:20 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')]} 07:06:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:06:20 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 0x1df91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fc6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2169d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2166eb0>, '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 0x2167db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2168240>, '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': 'a0d2d2de893abaa8702a9954000001a7-1502016693.72581-2051344785', '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 07:06:20 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 07:06:20 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 07:06:20 INFO - Using env: {'DISPLAY': ':0', 07:06:20 INFO - 'HOME': '/home/cltbld', 07:06:20 INFO - 'LANG': 'en_US.UTF-8', 07:06:20 INFO - 'LANGUAGE': 'en_US:en', 07:06:20 INFO - 'LOGNAME': 'cltbld', 07:06:20 INFO - 'MAIL': '/var/mail/cltbld', 07:06:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:06:20 INFO - 'MOZ_NO_REMOTE': '1', 07:06:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:06:20 INFO - 'NO_EM_RESTART': '1', 07:06:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:06:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:06:20 INFO - 'PWD': '/builds/slave/test', 07:06:20 INFO - 'SHELL': '/bin/bash', 07:06:20 INFO - 'SHLVL': '1', 07:06:20 INFO - 'TERM': 'linux', 07:06:20 INFO - 'TMOUT': '86400', 07:06:20 INFO - 'USER': 'cltbld', 07:06:20 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1502016693.72581-2051344785', 07:06:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:06:20 INFO - '_': '/tools/buildbot/bin/python'} 07:06:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:06:21 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)) 07:06:21 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)) 07:06:21 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)) 07:06:21 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)) 07:06:21 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)) 07:06:21 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)) 07:06:21 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)) 07:06:21 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)) 07:06:21 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)) 07:06:21 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 07:06:21 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 07:06:21 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 07:06:21 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 07:06:21 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 07:06:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 07:06:22 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)) 07:06:22 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)) 07:06:22 INFO - Installing collected packages: simplejson 07:06:22 INFO - Running setup.py install for simplejson 07:06:22 INFO - building 'simplejson._speedups' extension 07:06:22 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 07:06:23 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 07:06:23 INFO - Successfully installed simplejson 07:06:23 INFO - Cleaning up... 07:06:23 INFO - Return code: 0 07:06:23 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:06:23 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')]} 07:06:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:06:23 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')]} 07:06:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:06:23 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 0x1df91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fc6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2169d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2166eb0>, '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 0x2167db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2168240>, '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': 'a0d2d2de893abaa8702a9954000001a7-1502016693.72581-2051344785', '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 07:06:23 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 07:06:23 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 07:06:23 INFO - Using env: {'DISPLAY': ':0', 07:06:23 INFO - 'HOME': '/home/cltbld', 07:06:23 INFO - 'LANG': 'en_US.UTF-8', 07:06:23 INFO - 'LANGUAGE': 'en_US:en', 07:06:23 INFO - 'LOGNAME': 'cltbld', 07:06:23 INFO - 'MAIL': '/var/mail/cltbld', 07:06:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:06:23 INFO - 'MOZ_NO_REMOTE': '1', 07:06:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:06:23 INFO - 'NO_EM_RESTART': '1', 07:06:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:06:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:06:23 INFO - 'PWD': '/builds/slave/test', 07:06:23 INFO - 'SHELL': '/bin/bash', 07:06:23 INFO - 'SHLVL': '1', 07:06:23 INFO - 'TERM': 'linux', 07:06:23 INFO - 'TMOUT': '86400', 07:06:23 INFO - 'USER': 'cltbld', 07:06:23 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1502016693.72581-2051344785', 07:06:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:06:23 INFO - '_': '/tools/buildbot/bin/python'} 07:06:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:06:23 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:06:23 INFO - Cleaning up... 07:06:23 INFO - Return code: 0 07:06:23 INFO - Running post-action listener: _resource_record_post_action 07:06:23 INFO - Running post-action listener: _start_resource_monitoring 07:06:23 INFO - Starting resource monitoring. 07:06:23 INFO - [mozharness: 2017-08-06 14:06:23.558268Z] Finished create-virtualenv step (success) 07:06:23 INFO - [mozharness: 2017-08-06 14:06:23.558737Z] Running install step. 07:06:23 INFO - Running pre-action listener: _resource_record_pre_action 07:06:23 INFO - Running main action method: install 07:06:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:06:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:06:23 INFO - Reading from file tmpfile_stdout 07:06:23 INFO - Detecting whether we're running mozinstall >=1.0... 07:06:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:06:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:06:23 INFO - Reading from file tmpfile_stdout 07:06:23 INFO - Output received: 07:06:23 INFO - Usage: mozinstall [options] installer 07:06:23 INFO - Options: 07:06:23 INFO - -h, --help show this help message and exit 07:06:23 INFO - -d DEST, --destination=DEST 07:06:23 INFO - Directory to install application into. [default: 07:06:23 INFO - "/builds/slave/test"] 07:06:23 INFO - --app=APP Application being installed. [default: firefox] 07:06:23 INFO - mkdir: /builds/slave/test/build/application 07:06:23 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'] 07:06:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 07:06:41 INFO - Reading from file tmpfile_stdout 07:06:41 INFO - Output received: 07:06:41 INFO - /builds/slave/test/build/application/firefox/firefox 07:06:41 INFO - Running post-action listener: _resource_record_post_action 07:06:41 INFO - [mozharness: 2017-08-06 14:06:41.894996Z] Finished install step (success) 07:06:41 INFO - [mozharness: 2017-08-06 14:06:41.895277Z] Running setup-mitmproxy step. 07:06:41 INFO - Running pre-action listener: _resource_record_pre_action 07:06:41 INFO - Running main action method: setup_mitmproxy 07:06:41 INFO - Skipping: mitmproxy is not required 07:06:41 INFO - Running post-action listener: _resource_record_post_action 07:06:41 INFO - [mozharness: 2017-08-06 14:06:41.896430Z] Finished setup-mitmproxy step (success) 07:06:41 INFO - [mozharness: 2017-08-06 14:06:41.896652Z] Running run-tests step. 07:06:41 INFO - Running pre-action listener: _resource_record_pre_action 07:06:41 INFO - Running pre-action listener: _set_gcov_prefix 07:06:41 INFO - Running main action method: run_tests 07:06:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:06:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:06:41 INFO - Python 2.7.3 07:06:41 INFO - Return code: 0 07:06:41 INFO - grabbing minidump binary from tooltool 07:06:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:06:41 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 0x2166eb0>, '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 0x2167db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2168240>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:06:41 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 07:06:41 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 07:06:41 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 07:06:41 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:06:42 INFO - Return code: 0 07:06:42 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:06:42 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:06:42 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:06:42 INFO - ENV: RUST_BACKTRACE is now 1 07:06:42 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:06:42 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:06:42 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/Ph1H-2ZlRnGCNKdcz7C8dw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-002', '--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 07:06:42 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/Ph1H-2ZlRnGCNKdcz7C8dw/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-002 --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 07:06:42 INFO - Using env: {'DISPLAY': ':0', 07:06:42 INFO - 'HOME': '/home/cltbld', 07:06:42 INFO - 'LANG': 'en_US.UTF-8', 07:06:42 INFO - 'LANGUAGE': 'en_US:en', 07:06:42 INFO - 'LOGNAME': 'cltbld', 07:06:42 INFO - 'MAIL': '/var/mail/cltbld', 07:06:42 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:06:42 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:06:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:06:42 INFO - 'MOZ_NO_REMOTE': '1', 07:06:42 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:06:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:06:42 INFO - 'NO_EM_RESTART': '1', 07:06:42 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:06:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:06:42 INFO - 'PWD': '/builds/slave/test', 07:06:42 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:06:42 INFO - 'RUST_BACKTRACE': '1', 07:06:42 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 07:06:42 INFO - 'SHELL': '/bin/bash', 07:06:42 INFO - 'SHLVL': '1', 07:06:42 INFO - 'TERM': 'linux', 07:06:42 INFO - 'TMOUT': '86400', 07:06:42 INFO - 'USER': 'cltbld', 07:06:42 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1502016693.72581-2051344785', 07:06:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:06:42 INFO - '_': '/tools/buildbot/bin/python'} 07:06:42 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/Ph1H-2ZlRnGCNKdcz7C8dw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-002', '--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 07:06:42 INFO - mozversion application_buildid: 20170806090558 07:06:42 INFO - mozversion application_changeset: fe6609d22dfdd710b11e3ac7773aff89f7a8d12c 07:06:42 INFO - mozversion application_display_name: Nightly 07:06:42 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:06:42 INFO - mozversion application_name: Firefox 07:06:42 INFO - mozversion application_remotingname: firefox 07:06:42 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 07:06:42 INFO - mozversion application_vendor: Mozilla 07:06:42 INFO - mozversion application_version: 57.0a1 07:06:42 INFO - mozversion platform_buildid: 20170806090558 07:06:42 INFO - mozversion platform_changeset: fe6609d22dfdd710b11e3ac7773aff89f7a8d12c 07:06:42 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 07:06:42 INFO - mozversion platform_version: 57.0a1 07:06:42 INFO - using testdate: 1502028402 07:06:42 INFO - actual date: 1502028402 07:06:42 INFO - starting webserver on 'localhost:57347' 07:06:42 INFO - SUITE-START | Running 2 tests 07:06:42 INFO - TEST-START | dromaeo_css 07:06:42 INFO - Initialising browser for dromaeo_css test... 07:06:42 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:57347/getInfo.html -profile /tmp/tmpo3wSNK/profile 07:06:42 INFO - TEST-INFO | started process 14563 (/builds/slave/test/build/application/firefox/firefox http://localhost:57347/getInfo.html) 07:06:48 INFO - TEST-INFO | 14563: exit 0 07:06:48 INFO - Browser initialized. 07:06:48 INFO - Running cycle 1/1 for dromaeo_css test... 07:06:48 INFO - TEST-INFO | started process 14771 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpo3wSNK/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 07:06:49 INFO - PID 14771 | 07:06:49 INFO - PID 14771 | (/builds/slave/test/build/application/firefox/firefox:14818): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 07:06:49 INFO - PID 14771 | 07:06:59 INFO - PID 14771 | RSS: Main: 171384832 07:06:59 INFO - PID 14771 | 07:09:59 INFO - PID 14771 | Cycle 1(1): loaded http://localhost:57347/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57347/tests/dromaeo/cssquery-ext.html) 07:10:00 INFO - PID 14771 | RSS: Main: 173084672 07:10:00 INFO - PID 14771 | 07:13:02 INFO - PID 14771 | Cycle 1(1): loaded http://localhost:57347/tests/dromaeo/cssquery-ext.html (next: http://localhost:57347/tests/dromaeo/cssquery-jquery.html) 07:13:03 INFO - PID 14771 | RSS: Main: 169025536 07:13:03 INFO - PID 14771 | 07:16:04 INFO - PID 14771 | Cycle 1(1): loaded http://localhost:57347/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57347/tests/dromaeo/cssquery-mootools.html) 07:16:05 INFO - PID 14771 | RSS: Main: 173289472 07:16:05 INFO - PID 14771 | 07:19:07 INFO - PID 14771 | Cycle 1(1): loaded http://localhost:57347/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57347/tests/dromaeo/cssquery-prototype.html) 07:19:07 INFO - PID 14771 | RSS: Main: 171065344 07:19:07 INFO - PID 14771 | 07:22:11 INFO - PID 14771 | Cycle 1(1): loaded http://localhost:57347/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57347/tests/dromaeo/cssquery-yui.html) 07:22:12 INFO - PID 14771 | RSS: Main: 175026176 07:22:12 INFO - PID 14771 | 07:25:13 INFO - PID 14771 | Cycle 1(1): loaded http://localhost:57347/tests/dromaeo/cssquery-yui.html (next: http://localhost:57347/tests/dromaeo/cssquery-dojo.html) 07:25:14 INFO - PID 14771 | RSS: Main: 175464448 07:25:14 INFO - PID 14771 | 07:25:14 INFO - PID 14771 | __start_tp_report 07:25:14 INFO - PID 14771 | _x_x_mozilla_page_load 07:25:14 INFO - PID 14771 | _x_x_mozilla_page_load_details 07:25:14 INFO - PID 14771 | |i|pagename|runs| 07:25:14 INFO - PID 14771 | |0;dojo.html;3158.936821263575;3175.444297247981;3186.474231751761;3201.183698156971;3203.6155661320645;6239.126522286872;6288.182536270278;6300.495960323175;6350.110984462179;6374.394432528914;6170.598911070777;6308.558400911938;6310;6323;6342.14381058557;5775.2203452534;5792.507636850873;5831.620944638596;5874.676892770896;5884.440978107073;5638.689872057035;5771.105478650816;5797.71011449428;5949.613275137102;5953.464188223059;5725.685087320196;5786.508146807484;5801.535877129841;5858.326292476378;5870.324912635059;5784.797532086357;5825;5857.648541087548;5862.677552734598;5886.823395298148;5636.887262254773;5671.6597004179885;5721.628094173865;5729.828105156852;5736.2542869427125;6208.87582248357;6217.098520714516;6297.811065668037;6307.27466341372;6312.463440607554;6733.764318248886;6780;6786.185657721105;6817.5568588041615;6834.1457317835275;6797.1843378794365;6805.455563554904;6842.589444633338;6913.619750913697;6923.792286231421;6187.319394866561;6281.246250449975;6287.1198032275515;6289;6323.430891219767;6922.203946546211;6950.3049695030095;6954.09596752429;7034.8944765828555;7048;6694.397504224643;6737;6741.1236539249585;6743.460523158135;6747.561408508432;6823.078884350549;6829.6243706596615;6829.692663830139;6853.00631408453;6862.073620061327;6715.832104197434;6746.190457145076;6803;6805.761798337134;6814.216365117975;6648.5346025777735;6744.12326397575;6787.04981302618;6839.418649414756;6857.862842743117;5417.783288668409;5423.810166644149;5437.075697131497;5446.291982042309;5506.981208476444;4695.671303008825;4724.244120940633;4747.169245382044;4748.097861406391;4749.145153872336;5781.5952883298605;5852.473277404969;5862.560307976919;5871.64770113786;5880.529557635379;6818.454523638097;6819.215790184192;6826.044353790473;6907.965460172667;6922.342377474132;5684.54523638108;5749.8562535936935;5764.048931926185;5792.536597072224;5828.242328497268;5914.201582786355;5961.850953726105;5968.940310596925;5982.790602328898;5988.760449581968;6399.712012959428;6508.219013718384;6512.674366281667;6521.510886683518;6523.510736694767;6689.464842812563;6802.387785099365;6805.965970170316;6853.760118395832;6938.375546200866;6507.6746162692625;6514.120593719787;6532.8366790830605;6615.140031795836;6616.90074648871;6562.376574225632;6658.5671931324305;6680.866382672222;6696.129503164558;6741.22475915276;6771.322867713189;6786.253512113763;6787.66061696923;6790.830229244309;6793.252742198453;6543.6400997943665;6547.836304092436;6575.638339891352;6580.967095164494;6685.064091027358;6624.436922861611;6654.035164901159;6686.866262674816;6729.629870357177;6736.360045795642;6546.509011824037;6559.901601476077;6593.241777195684;6647.567908085959;6648.301928297459;6610.867782644224;6668.133142691419;6776.796696099125;6777.593344399154;6777.661116944231;6426.807195784134;6451.48388128958;6471.449926756279;6544.54188206821;6557.311482294481 07:25:14 INFO - PID 14771 | |1;ext.html;758.7382353088186;784.6273020315348;806.5241507510569;819.5492479136477;839.6599377252213;40886.79556602216;41871.37192942108;41936.79031604838;41956;41982.58017419825;37858.621413785855;38162.61837381625;38218.23563528728;38327.42508862369;38494.615053849455;6722.731090756376;6831.248562658104;6836.555623884432;6839.316068393171;6858.3141685831515;6752.729890804362;6779.322067793206;6818.284080171585;6829.692663830139;6850.417714494274;7342.926570734277;7508.1741008489025;7538.547687138762;7580.886286705704;7606.885896711554;7518.360939320164;7556.093268807724;7582.317591416771;7583.924160758377;7585.620718964057;7310.195878453366;7407.703691852374;7493.4005279577505;7514.135874374462;7517.398608111338;39076.41385379222;39287.8035609823;39327.606723932964;39353.21293574141;39364.40953385702;3572.231970126409;3612.9096772580633;3621.0947263184203;3624.257027309395;3633.6911362534215;31512.36975260482;31585.684143158505;31731.841340793148;31770.364592708018;31845.363092738247;4983.053219888209;4991.4758950310425;4998.225275082332;5043.495650434964;5047.217681259411;233285;238537;239209;240331;241103;50449;50877.23684144741;50885;50939.49060509347;50987.74506127446;51908.22137667938;51939.22091168635;52096.73951630218;52177.73911130496;52249.47750522446;16790;16968.91515542439;17030.57423564396;17041.48875533736;17046.318147274218;13900.582982510541;14074;14081.436742530184;14095.647608809657;14155.787663185061;14969.101853888802;15010.099394036393;15010.099394036393;15084.773728394082;15245.847541524443;5742.827715168552;5878.177055212273;5900.365151280517;6020.879582408327;6081.0270356743595;985.8225519406576;1008.5360734062414;1019.5615885169449;1024.1192574386023;1025.4001409175567;23659.526809463714;24073.7592624075;24077.759222407552;24170;24200.394990125387;1115.2137742891243;1123.5112725964068;1132.592266783957;1136.7385501334575;1139.350570175009;12379.133460657848;12524.060695447877;16901.408450704166;16944.661106777796;17015.744763828552;234863;235261;235314;236072;237033;49057.75471122622;49644.25533616998;58382.70808645929;59489;60092;1426.2939844776695;1490.1506141499242;1493.9103653780808;1499.4077339451073;1504.2253239581623;28064.71935280621;28674;28676.42647147087;29224;29758.55362169526;52970.470295298095;53545;53651.46348536465;53701.73149134385;53720;209297;211180;212011;212127;212668;35882;36487;39253.60746392499;40510.59489405068;40531.59468405396;47879.16966642591;48815;49493.752531237114;50008.499915000386;50232.24651630155;35586;35697.28605427825;35852.64147358597;35904.82047589745;35956.640433596374;34650;34907;34923.825380872935;34948.65051349556;35248.295034098664;36693.26613467769;38224.23551529009;38503.422448663856;38533.614663853004;38595.421068684554;33797.83101084479;34344;34466;34493;34729;26162.215133546026;26386.736132639195;26410.603840942786;26604.068857589893;26761.33096672599 07:25:14 INFO - PID 14771 | |2;jquery.html;570.7003822992929;581.7672930827669;583.7606581301667;585.1661382529895;591.6479694581723;22202.222922197725;23076;23080.538389232206;23096.88451557744;23113.653295200584;25469;26729;27816.3045923852;27914.581281280745;27991.160265192077;6530.771423000196;6704.2625311215725;6706.899396509032;6712.563683360566;6713.597184168965;6207.565470417073;6489.935100648981;6547.77082802102;6629.071929929813;6632.369924857131;6429.967850160766;6469.450096741759;6480.287168411471;6481.060246264289;6482.546221764478;6449.677516124222;6477.0284457331545;6489.805305840832;6493.253275873264;6493.7727179548965;5988.221531200959;6009.218801555813;6020.5785595008365;6026.306974697922;6031;29769.553456698166;30368.8481557593;30466.238344041354;30508.54237186444;31492.842535787404;1858.2381223698353;1916.1281616864433;1917;1919.9904000479908;1921.8174273444001;19545.413637590897;20146.39560813178;20172;20277.797222027737;20345.8982705087;2416.226807421626;2459.8401103928186;2480.8635525046116;2485.3041148478455;2516.3834860459124;142982;146017;146955;147045;147646;14283.214423206824;15013.774793378108;15332.693346133237;15511.457099001707;15699.607509812346;23534.529309413716;24064.75935240625;24121;24241;24304.270871873872;10595.894041059644;10711.143108551298;10911.399873007062;10958.452077396098;11037.282576632653;10074.093331600192;10129.797404052026;10151.289409741396;10234.795304094025;10361.689149325532;9555.808883822423;9599.904000960041;9670.468124253233;9684.903150968541;9691.951540242253;2657.6545049143874;2717.3070866928806;2791.3858951030743;2870.985645071761;2882.798204125691;952.590386133969;968.0996673093949;974.6247694637616;984.5864736810556;988.3921388346115;20282.188712451338;20428.591428171352;20439.591208175752;20666;20680.793192067886;1031.6389263757774;1033.426448321174;1035.2028937717914;1052.347544522401;1052.5158427123456;10923.672289831318;11426.371549564854;11439.970402663801;11481;11504.94247528757;492046;541059;541838;547157;550161;114652;117452.41273793577;118271.40864295796;119335.40332298283;120473.39763301128;1208.075658465691;1213.3629844331797;1230.3848075962019;1231.956881509161;1237.294741997071;17929.551761206076;18136;18355.816441835945;18653.813461865208;21772.34682959514;59427.40572594219;59674.403255966885;60494;61863.6906815463;62011.37988620237;68567;68797.65601171962;68892.3110768886;69300.30699693141;69863.65068174627;14940.925295373454;15315.234238288263;15408.075515469107;15481.922590387427;15483.612909676898;23577;23584.882075589514;23667.52664946657;23969.16107936214;24015;18195.727064094313;18862.622747545247;19228.230870765572;19260.614787704446;19396.4181074568;17526.912365438093;17614.383496577557;17645.911770441067;17897.10514474297;18195.727064093786;19832.008399579674;20035.39893803188;20109.49726256855;20119.798802011792;20224.089915953522;14596.708065838411;14927.925360373129;15508.612284692974;15559.922200388926;15560.377584896478;18816.15327310247;18871.15079821439;18946.336878209197;19044;19171.424857254304 07:25:14 INFO - PID 14771 | |3;mootools.html;1358.9796153057705;1410.1186758276078;1436.7701167813138;1442.6249175214448;1446.4286606790317;13158.868411315883;13643.249621270827;13655.522056727992;13680.38438270279;14278;14820.481283155092;15123.92438037811;15139.621509462242;15141;15155.545333640008;2726.4410795786816;2794.5249307617755;2795.35706787439;2795.454886297173;2795.664520257572;2716.415970566328;2787.6097346371525;2804.761595264405;2805.3968396794685;2807.6069350290873;2704.0806125917184;2716.9592456113173;2744.4922689302443;2744.7529722324985;2763.77889768818;2680.2629276948896;2695.3800625855965;2723.1830450864663;2724.8773805178716;2752.7612574341424;2629.0404002539126;2659.534581448239;2661.308059904419;2665.4935562243304;2674.4918465491496;13671.86328136716;13981.930090349584;14005.859941400658;14009.159450433006;14019.43922243109;7794.2205779422175;8113.066997295327;8120.309773669245;8122.796930076736;8124.796880077986;5044.495550444926;5093.236014597803;5199.818006369759;5269.2886460327745;5283.207518872162;1843.1613615804777;1847.3349594146232;1850.7871594766639;1887.6979683250752;1890.5651700109051;22598.322050338353;23229;23233.419164520852;23245.18641847544;23254.65118023231;7022.683979220948;7088.7872575303745;7205.423566114699;7217.206107328189;7304.160021597478;16122.919385402998;16245.131809841783;16294.837051629569;16367.181640917906;16388.75416868724;7683.193264707237;7812.414068944852;7821.256980586949;7826.0608726952;7826.921730782619;7126.608036558039;7205.207427183006;7257.745978890714;7259.927400726031;7269.6728647211;5026.195808670595;5173.896522069537;5193.844184674465;5212.739363031909;5234.18870075139;1508.7887695722607;1512.780646806207;1518.202943454695;1531.240803826603;1544.4131230132703;863.7149740585592;867.6139118092389;890.1098901098901;893.9016708162097;906.3247880329197;7128.322809333105;7200.567965922061;7220.205777364486;7252.492325537161;7271.927280727231;722.8482018776011;735.3749313083943;743.3272888036336;986.5708416838555;1013;5042.319286896295;5086.033653605803;5191.6884986900905;5228.686278823283;5270.209468579667;17889.28442862271;18305.90164590129;18481.7227741584;18554.44336669902;18606.627867442847;17741.55646108832;18122.184501697455;18131.909340453476;18136.546586335448;18328.083595820422;10965.671029869116;11155.832662510069;11210.831837522444;11224.102071834233;11305.26515776472;8129.918700813153;8412.62143203545;8450.873236901574;8462.661493540189;8525.531095789791;17248.827511725223;17262.395816146374;17373.21820518105;17813.821861781216;17848.821511784718;17596.82403175952;17646.20592073334;17658;17902.91048544749;18271.269149234413;10654.094401975608;10937.179711521827;10939.070179034552;10943.179261555575;10945.23383363157;13152.671183220113;13195.802062969255;13244.470221191044;13329;13363;10398.948005259925;10510.421926794099;10514.053735163872;10519.421431821018;10807.459627018774;10465.319754215952;10522.684319470429;10607;10659.626913058006;10904.836427453753;9420.199283060743;9655.179309758749;9655.179309758749;9660.420374777535;9666;6886.311368863074;6919.446444284546;6986.895196572157;7292.854142917218;7372.447066470144;7145.285471452813;7289.5261807982315;7297.306755858185;7318.890216646861;7386.519876208029 07:25:14 INFO - PID 14771 | |4;prototype.html;500.68682685990706;500.69568773345435;522.9241759944808;534.2173715506784;535.0476152448642;6244.7510497900485;6434.356564343575;6452.64510451925;6456.935430645698;6511.153550038494;6179.814605561829;6191.6285022898655;6213.689315534228;6256.343083976185;6276.246850377961;5012.874678133039;5025.296458495814;5034.723090230036;5056.926660069373;5083.466236045218;4952.415227127321;5003;5042.4201216860165;5069.974650126745;5235.921461178085;5157.381114266274;5177.767000484987;5195.142801437758;5266.947330526684;5271.762770675309;5241.842744717665;5254.474552544753;5279.222303815053;5298.36419629643;5307.681539107666;4898.510148985109;4916.729579873106;4919.139150648658;4919.237518184651;4980.526849949249;6234.659548197159;6245.56281060326;6256.562040657156;6273.592216505913;6311.715972781236;6094.567776572502;6095.3904609538695;6111.755529778803;6136.539759518054;6187.4740647045055;6694.991502549265;6703.698333575001;6738.326167383271;6747.561408508432;6752.797416077526;5141.383034035902;5349.812756553541;5360.927814437128;5378.757955891955;5392.622516423852;7016.543924644881;7025.929740702579;7084.645767711594;7134.785956421316;7244.963775181091;5570.972145139248;5576.832695019075;5577.191307260425;5614.803481878114;5659.688717120515;5601.29983752031;5601.80393686219;5603.467670571289;5605.663660180402;5672;6034.577579569388;6083.452489275986;6103.755849766048;6118.5716999810475;6139.938600614026;6673.833154171088;6691.197056353269;6747.954067119605;6749.460043196533;6780.355866192704;1873.4192400355932;1924.9518762031062;1928.80711928806;1981.682930731105;1986.1161783006423;1377.6486995816003;1425.0452197028017;1427.635952832021;1439.7696368581187;1450.4343306110625;5703.800366987136;5723.055695810228;5762.769489220468;5783.306003279549;5789.8263052108505;6751.223609284897;6751.662416879137;6791.626460544718;6914.686209620156;6944.236134025355;5778.56660750437;5794.68212714909;5811.535077193815;5852.239208902815;5858.0248146889935;3628.4194528875782;3629.854805807738;3642.7450078494253;3659.7804131751645;3688.446732990073;6607.900881486781;6622.801315960529;6654.467642588581;6656.933430665631;6718.428933540606;6991.370776630128;7025.873486298548;7078.504504684725;7097.148342198866;7121.786346409616;6463.450606698483;6487.345726839626;6607.075009498674;6661.367170118734;6756.966215168893;6850.554713943578;6898.448124150156;6906.723731050903;6917.336825322388;6993.930060699531;6713.295104014203;6758.966205168943;6807.693653785493;6813.557118787263;6882.174139103139;6646.404862832982;6669.366005328726;6711.959646254838;6728.461723062045;6754.86490270182;5025.899482010413;5072.442031376472;5074.543291103819;5102.72431892027;5130.923036154386;6700.49746269022;6923.653817309014;7001.0198572198915;7011.4741394394605;7027.8945815811785;6346.650934198663;6538.803835884931;6621.172353455818;6658.966705166443;6666.600003999775;6524.063102576632;6553.475721942328;6708.6310252936555;6722;6727.8990815138795;6498.902516462352;6534.542582019213;6572.967135164294;6603.339666033358;6617.073609694743;6592.538522303393;6703.865922681422;6709.194896612437;6739.393454589111;6762.594244345355;6442.323556026738;6495.253045899593;6501.2523559791225;6503.934960650522;6524.510661700487 07:25:14 INFO - PID 14771 | |5;yui.html;904.7738065483629;916.5234078279295;923.9445633262009;930.5765876526182;938.8169306985138;19627.607447851053;20505.692414613794;20518.17927282909;20524.486887827792;20539.589208215828;17586.736198956994;18003.27986880523;18053.458396248134;18055;22466.32601021972;993.9105480506753;1014.0417305646167;1015.939043657383;1023.0332335942537;1023.1098943918764;1073.6886302972168;1074.2694967422149;1075.0969185883855;1078.471548941017;1079.740862193072;1010.9797804043915;1102.5920409448515;1112.3881864974271;1118.2954738514725;1118.8545489086448;1103.2222283290262;1110.4780753046055;1110.7945030169403;1111.1166622535104;1112.6328311657173;800.6357107516067;805.6173317674117;812.3257696112213;812.4312980913385;813.2558708781517;19129.330473433503;19310;20103.597928041505;20196.798032019786;20422.489437764027;22457.775422245733;22561.323160305215;22954.885225573933;22994.08023679051;23028.424289392733;16584.50246492607;16893.324267029304;16904.323827046905;17190.398336058177;18083.36708215206;3629.0745859805843;3692.2246328271094;3715.981420092909;3716.4982727331735;3716.6655001050035;131413;134589;135665;138701;138720.30639846838;17164.828351716573;17401.91299043497;17892.194851231725;17893.552661183316;17933.641327173646;31655.84172079171;32208.516872246935;32584.185395365304;32851.3429731404;32875.17812054718;8850.424722393023;8939.821203575892;8965.148310910454;9122.361434699507;9196.540172991323;4240.554741752133;4300.935485967713;4306.89232769177;4316.676249281317;4341.544137865479;5411;5482;5511.889762204733;5515;5528.44715528444;1012.5595366015807;1028.88682244953;1040.5109598488698;1042.0985847242232;1042.760165162017;492.1706923833352;510.9259157422153;511.8643559456747;513.8330042736126;513.9357580302462;10940.288881222854;10944.23390362683;11158.553657853758;11775.293482391084;11806.822897656542;567.2852206220192;569.3907518954679;575.2550447170923;581.9592628516048;590.5541316306161;4928.408590969107;5372.8448383597715;5380.219868119179;5596.2165296858475;5793.942060579425;99575;101097;102372.48813756033;103176.48411758043;106048;96232;98123;98562;101644.49177754064;101786;82347.58826205951;83074.58462707768;83797.16202838016;84285.57857210797;84848;11786.646400607995;12298.631041068782;12419.93790031044;12436.37818109109;12663.746725065632;35682.28635427329;37616.43575346317;37770;38521.422178667905;39267;48202;48449;50533;68534.65732671304;73699.63150184214;17020.48938531846;17184.484465466056;17232.827671723124;17349.045802480985;17349.21928513245;17990;18289.26842926321;18327.35854245095;18682;18980.810191897905;16767.32930682759;16831.41090061842;16869.493915182564;16914.154292285584;16962.915185423994;16390.508284751475;16600.2529886153;16698.74951875747;16732.832671673616;16832;14664.560063198121;14749.852501475278;14956.551303460914;15181.544553663407;15624.531264062096;12658.746825063263;12986.935065324613;12988.285644289277;13006.544770932973;13100.213987160801;12968.935155324163;13200.603981880558;13477.865221348053;13733.244671542761;14210.431582736575 07:25:14 INFO - PID 14771 | __end_tp_report 07:25:14 INFO - PID 14771 | __start_cc_report 07:25:14 INFO - PID 14771 | _x_x_mozilla_cycle_collect,401 07:25:14 INFO - PID 14771 | __end_cc_report 07:25:14 INFO - PID 14771 | __startTimestamp1502029514052__endTimestamp 07:25:14 INFO - PID 14771 | 07:25:14 INFO - PID 14771 | ------- Summary: start ------- 07:25:14 INFO - PID 14771 | Number of tests: 6 07:25:14 INFO - PID 14771 | 07:25:14 INFO - PID 14771 | [#0] dojo.html Cycles:165 Average:6245.72 Median:6514.12 stddev:746.42 (11.5%) stddev-sans-first:708.34 07:25:14 INFO - PID 14771 | Values: 3158.9 3175.4 3186.5 3201.2 3203.6 6239.1 6288.2 6300.5 6350.1 6374.4 6170.6 6308.6 6310.0 6323.0 6342.1 5775.2 5792.5 5831.6 5874.7 5884.4 5638.7 5771.1 5797.7 5949.6 5953.5 5725.7 5786.5 5801.5 5858.3 5870.3 5784.8 5825.0 5857.6 5862.7 5886.8 5636.9 5671.7 5721.6 5729.8 5736.3 6208.9 6217.1 6297.8 6307.3 6312.5 6733.8 6780.0 6786.2 6817.6 6834.1 6797.2 6805.5 6842.6 6913.6 6923.8 6187.3 6281.2 6287.1 6289.0 6323.4 6922.2 6950.3 6954.1 7034.9 7048.0 6694.4 6737.0 6741.1 6743.5 6747.6 6823.1 6829.6 6829.7 6853.0 6862.1 6715.8 6746.2 6803.0 6805.8 6814.2 6648.5 6744.1 6787.0 6839.4 6857.9 5417.8 5423.8 5437.1 5446.3 5507.0 4695.7 4724.2 4747.2 4748.1 4749.1 5781.6 5852.5 5862.6 5871.6 5880.5 6818.5 6819.2 6826.0 6908.0 6922.3 5684.5 5749.9 5764.0 5792.5 5828.2 5914.2 5961.9 5968.9 5982.8 5988.8 6399.7 6508.2 6512.7 6521.5 6523.5 6689.5 6802.4 6806.0 6853.8 6938.4 6507.7 6514.1 6532.8 6615.1 6616.9 6562.4 6658.6 6680.9 6696.1 6741.2 6771.3 6786.3 6787.7 6790.8 6793.3 6543.6 6547.8 6575.6 6581.0 6685.1 6624.4 6654.0 6686.9 6729.6 6736.4 6546.5 6559.9 6593.2 6647.6 6648.3 6610.9 6668.1 6776.8 6777.6 6777.7 6426.8 6451.5 6471.4 6544.5 6557.3 07:25:14 INFO - PID 14771 | 07:25:14 INFO - PID 14771 | [#1] ext.html Cycles:180 Average:40975.43 Median:36590.13 stddev:59365.05 (162.2%) stddev-sans-first:59454.78 07:25:14 INFO - PID 14771 | Values: 758.7 784.6 806.5 819.5 839.7 40886.8 41871.4 41936.8 41956.0 41982.6 37858.6 38162.6 38218.2 38327.4 38494.6 6722.7 6831.2 6836.6 6839.3 6858.3 6752.7 6779.3 6818.3 6829.7 6850.4 7342.9 7508.2 7538.5 7580.9 7606.9 7518.4 7556.1 7582.3 7583.9 7585.6 7310.2 7407.7 7493.4 7514.1 7517.4 39076.4 39287.8 39327.6 39353.2 39364.4 3572.2 3612.9 3621.1 3624.3 3633.7 31512.4 31585.7 31731.8 31770.4 31845.4 4983.1 4991.5 4998.2 5043.5 5047.2 233285.0 238537.0 239209.0 240331.0 241103.0 50449.0 50877.2 50885.0 50939.5 50987.7 51908.2 51939.2 52096.7 52177.7 52249.5 16790.0 16968.9 17030.6 17041.5 17046.3 13900.6 14074.0 14081.4 14095.6 14155.8 14969.1 15010.1 15010.1 15084.8 15245.8 5742.8 5878.2 5900.4 6020.9 6081.0 985.8 1008.5 1019.6 1024.1 1025.4 23659.5 24073.8 24077.8 24170.0 24200.4 1115.2 1123.5 1132.6 1136.7 1139.4 12379.1 12524.1 16901.4 16944.7 17015.7 234863.0 235261.0 235314.0 236072.0 237033.0 49057.8 49644.3 58382.7 59489.0 60092.0 1426.3 1490.2 1493.9 1499.4 1504.2 28064.7 28674.0 28676.4 29224.0 29758.6 52970.5 53545.0 53651.5 53701.7 53720.0 209297.0 211180.0 212011.0 212127.0 212668.0 35882.0 36487.0 39253.6 40510.6 40531.6 47879.2 48815.0 49493.8 50008.5 50232.2 35586.0 35697.3 35852.6 35904.8 35956.6 34650.0 34907.0 34923.8 34948.7 35248.3 36693.3 38224.2 38503.4 38533.6 38595.4 33797.8 34344.0 34466.0 34493.0 34729.0 26162.2 26386.7 26410.6 26604.1 26761.3 07:25:14 INFO - PID 14771 | 07:25:14 INFO - PID 14771 | [#2] jquery.html Cycles:180 Average:36752.04 Median:22639.11 stddev:89779.35 (396.6%) stddev-sans-first:89990.10 07:25:14 INFO - PID 14771 | Values: 570.7 581.8 583.8 585.2 591.6 22202.2 23076.0 23080.5 23096.9 23113.7 25469.0 26729.0 27816.3 27914.6 27991.2 6530.8 6704.3 6706.9 6712.6 6713.6 6207.6 6489.9 6547.8 6629.1 6632.4 6430.0 6469.5 6480.3 6481.1 6482.5 6449.7 6477.0 6489.8 6493.3 6493.8 5988.2 6009.2 6020.6 6026.3 6031.0 29769.6 30368.8 30466.2 30508.5 31492.8 1858.2 1916.1 1917.0 1920.0 1921.8 19545.4 20146.4 20172.0 20277.8 20345.9 2416.2 2459.8 2480.9 2485.3 2516.4 142982.0 146017.0 146955.0 147045.0 147646.0 14283.2 15013.8 15332.7 15511.5 15699.6 23534.5 24064.8 24121.0 24241.0 24304.3 10595.9 10711.1 10911.4 10958.5 11037.3 10074.1 10129.8 10151.3 10234.8 10361.7 9555.8 9599.9 9670.5 9684.9 9692.0 2657.7 2717.3 2791.4 2871.0 2882.8 952.6 968.1 974.6 984.6 988.4 20282.2 20428.6 20439.6 20666.0 20680.8 1031.6 1033.4 1035.2 1052.3 1052.5 10923.7 11426.4 11440.0 11481.0 11504.9 492046.0 541059.0 541838.0 547157.0 550161.0 114652.0 117452.4 118271.4 119335.4 120473.4 1208.1 1213.4 1230.4 1232.0 1237.3 17929.6 18136.0 18355.8 18653.8 21772.3 59427.4 59674.4 60494.0 61863.7 62011.4 68567.0 68797.7 68892.3 69300.3 69863.7 14940.9 15315.2 15408.1 15481.9 15483.6 23577.0 23584.9 23667.5 23969.2 24015.0 18195.7 18862.6 19228.2 19260.6 19396.4 17526.9 17614.4 17645.9 17897.1 18195.7 19832.0 20035.4 20109.5 20119.8 20224.1 14596.7 14927.9 15508.6 15559.9 15560.4 18816.2 18871.2 18946.3 19044.0 19171.4 07:25:14 INFO - PID 14771 | 07:25:14 INFO - PID 14771 | [#3] mootools.html Cycles:180 Average:8775.79 Median:2677.38 stddev:5891.73 (220.1%) stddev-sans-first:5881.90 07:25:14 INFO - PID 14771 | Values: 1359.0 1410.1 1436.8 1442.6 1446.4 13158.9 13643.2 13655.5 13680.4 14278.0 14820.5 15123.9 15139.6 15141.0 15155.5 2726.4 2794.5 2795.4 2795.5 2795.7 2716.4 2787.6 2804.8 2805.4 2807.6 2704.1 2717.0 2744.5 2744.8 2763.8 2680.3 2695.4 2723.2 2724.9 2752.8 2629.0 2659.5 2661.3 2665.5 2674.5 13671.9 13981.9 14005.9 14009.2 14019.4 7794.2 8113.1 8120.3 8122.8 8124.8 5044.5 5093.2 5199.8 5269.3 5283.2 1843.2 1847.3 1850.8 1887.7 1890.6 22598.3 23229.0 23233.4 23245.2 23254.7 7022.7 7088.8 7205.4 7217.2 7304.2 16122.9 16245.1 16294.8 16367.2 16388.8 7683.2 7812.4 7821.3 7826.1 7826.9 7126.6 7205.2 7257.7 7259.9 7269.7 5026.2 5173.9 5193.8 5212.7 5234.2 1508.8 1512.8 1518.2 1531.2 1544.4 863.7 867.6 890.1 893.9 906.3 7128.3 7200.6 7220.2 7252.5 7271.9 722.8 735.4 743.3 986.6 1013.0 5042.3 5086.0 5191.7 5228.7 5270.2 17889.3 18305.9 18481.7 18554.4 18606.6 17741.6 18122.2 18131.9 18136.5 18328.1 10965.7 11155.8 11210.8 11224.1 11305.3 8129.9 8412.6 8450.9 8462.7 8525.5 17248.8 17262.4 17373.2 17813.8 17848.8 17596.8 17646.2 17658.0 17902.9 18271.3 10654.1 10937.2 10939.1 10943.2 10945.2 13152.7 13195.8 13244.5 13329.0 13363.0 10398.9 10510.4 10514.1 10519.4 10807.5 10465.3 10522.7 10607.0 10659.6 10904.8 9420.2 9655.2 9655.2 9660.4 9666.0 6886.3 6919.4 6986.9 7292.9 7372.4 7145.3 7289.5 7297.3 7318.9 7386.5 07:25:14 INFO - PID 14771 | 07:25:14 INFO - PID 14771 | [#4] prototype.html Cycles:180 Average:5705.32 Median:6250.95 stddev:1546.38 (24.7%) stddev-sans-first:1500.57 07:25:14 INFO - PID 14771 | Values: 500.7 500.7 522.9 534.2 535.0 6244.8 6434.4 6452.6 6456.9 6511.2 6179.8 6191.6 6213.7 6256.3 6276.2 5012.9 5025.3 5034.7 5056.9 5083.5 4952.4 5003.0 5042.4 5070.0 5235.9 5157.4 5177.8 5195.1 5266.9 5271.8 5241.8 5254.5 5279.2 5298.4 5307.7 4898.5 4916.7 4919.1 4919.2 4980.5 6234.7 6245.6 6256.6 6273.6 6311.7 6094.6 6095.4 6111.8 6136.5 6187.5 6695.0 6703.7 6738.3 6747.6 6752.8 5141.4 5349.8 5360.9 5378.8 5392.6 7016.5 7025.9 7084.6 7134.8 7245.0 5571.0 5576.8 5577.2 5614.8 5659.7 5601.3 5601.8 5603.5 5605.7 5672.0 6034.6 6083.5 6103.8 6118.6 6139.9 6673.8 6691.2 6748.0 6749.5 6780.4 1873.4 1925.0 1928.8 1981.7 1986.1 1377.6 1425.0 1427.6 1439.8 1450.4 5703.8 5723.1 5762.8 5783.3 5789.8 6751.2 6751.7 6791.6 6914.7 6944.2 5778.6 5794.7 5811.5 5852.2 5858.0 3628.4 3629.9 3642.7 3659.8 3688.4 6607.9 6622.8 6654.5 6656.9 6718.4 6991.4 7025.9 7078.5 7097.1 7121.8 6463.5 6487.3 6607.1 6661.4 6757.0 6850.6 6898.4 6906.7 6917.3 6993.9 6713.3 6759.0 6807.7 6813.6 6882.2 6646.4 6669.4 6712.0 6728.5 6754.9 5025.9 5072.4 5074.5 5102.7 5130.9 6700.5 6923.7 7001.0 7011.5 7027.9 6346.7 6538.8 6621.2 6659.0 6666.6 6524.1 6553.5 6708.6 6722.0 6727.9 6498.9 6534.5 6573.0 6603.3 6617.1 6592.5 6703.9 6709.2 6739.4 6762.6 6442.3 6495.3 6501.3 6503.9 6524.5 07:25:14 INFO - PID 14771 | 07:25:14 INFO - PID 14771 | [#5] yui.html Cycles:180 Average:23230.67 Median:18308.31 stddev:32090.69 (175.3%) stddev-sans-first:32136.92 07:25:14 INFO - PID 14771 | Values: 904.8 916.5 923.9 930.6 938.8 19627.6 20505.7 20518.2 20524.5 20539.6 17586.7 18003.3 18053.5 18055.0 22466.3 993.9 1014.0 1015.9 1023.0 1023.1 1073.7 1074.3 1075.1 1078.5 1079.7 1011.0 1102.6 1112.4 1118.3 1118.9 1103.2 1110.5 1110.8 1111.1 1112.6 800.6 805.6 812.3 812.4 813.3 19129.3 19310.0 20103.6 20196.8 20422.5 22457.8 22561.3 22954.9 22994.1 23028.4 16584.5 16893.3 16904.3 17190.4 18083.4 3629.1 3692.2 3716.0 3716.5 3716.7 131413.0 134589.0 135665.0 138701.0 138720.3 17164.8 17401.9 17892.2 17893.6 17933.6 31655.8 32208.5 32584.2 32851.3 32875.2 8850.4 8939.8 8965.1 9122.4 9196.5 4240.6 4300.9 4306.9 4316.7 4341.5 5411.0 5482.0 5511.9 5515.0 5528.4 1012.6 1028.9 1040.5 1042.1 1042.8 492.2 510.9 511.9 513.8 513.9 10940.3 10944.2 11158.6 11775.3 11806.8 567.3 569.4 575.3 582.0 590.6 4928.4 5372.8 5380.2 5596.2 5793.9 99575.0 101097.0 102372.5 103176.5 106048.0 96232.0 98123.0 98562.0 101644.5 101786.0 82347.6 83074.6 83797.2 84285.6 84848.0 11786.6 12298.6 12419.9 12436.4 12663.7 35682.3 37616.4 37770.0 38521.4 39267.0 48202.0 48449.0 50533.0 68534.7 73699.6 17020.5 17184.5 17232.8 17349.0 17349.2 17990.0 18289.3 18327.4 18682.0 18980.8 16767.3 16831.4 16869.5 16914.2 16962.9 16390.5 16600.3 16698.7 16732.8 16832.0 14664.6 14749.9 14956.6 15181.5 15624.5 12658.7 12986.9 12988.3 13006.5 13100.2 12968.9 13200.6 13477.9 13733.2 14210.4 07:25:14 INFO - PID 14771 | -------- Summary: end -------- 07:25:14 INFO - PID 14771 | 07:25:14 INFO - TEST-INFO | 14771: exit 0 07:25:14 INFO - TEST-OK | dromaeo_css | took 1112494ms 07:25:14 INFO - TEST-START | kraken 07:25:14 INFO - Initialising browser for kraken test... 07:25:14 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:57347/getInfo.html -profile /tmp/tmpi9ANuS/profile 07:25:14 INFO - TEST-INFO | started process 15136 (/builds/slave/test/build/application/firefox/firefox http://localhost:57347/getInfo.html) 07:25:20 INFO - TEST-INFO | 15136: exit 0 07:25:20 INFO - Browser initialized. 07:25:20 INFO - Running cycle 1/1 for kraken test... 07:25:20 INFO - TEST-INFO | started process 15343 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpi9ANuS/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 07:25:21 INFO - PID 15343 | 07:25:21 INFO - PID 15343 | (/builds/slave/test/build/application/firefox/firefox:15390): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 07:25:21 INFO - PID 15343 | 07:25:31 INFO - PID 15343 | RSS: Main: 171540480 07:25:31 INFO - PID 15343 | 07:25:34 INFO - PID 15343 | Cycle 1(1): loaded http://localhost:57347/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57347/tests/kraken/driver.html?testName=audio-beat-detection) 07:25:35 INFO - PID 15343 | RSS: Main: 177868800 07:25:35 INFO - PID 15343 | 07:25:38 INFO - PID 15343 | Cycle 1(1): loaded http://localhost:57347/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57347/tests/kraken/driver.html?testName=audio-dft) 07:25:38 INFO - PID 15343 | RSS: Main: 177860608 07:25:38 INFO - PID 15343 | 07:25:41 INFO - PID 15343 | Cycle 1(1): loaded http://localhost:57347/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57347/tests/kraken/driver.html?testName=audio-fft) 07:25:42 INFO - PID 15343 | RSS: Main: 171003904 07:25:42 INFO - PID 15343 | 07:25:44 INFO - PID 15343 | Cycle 1(1): loaded http://localhost:57347/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57347/tests/kraken/driver.html?testName=audio-oscillator) 07:25:45 INFO - PID 15343 | RSS: Main: 171700224 07:25:45 INFO - PID 15343 | 07:25:47 INFO - PID 15343 | Cycle 1(1): loaded http://localhost:57347/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57347/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:25:47 INFO - PID 15343 | RSS: Main: 172253184 07:25:47 INFO - PID 15343 | 07:25:50 INFO - PID 15343 | Cycle 1(1): loaded http://localhost:57347/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57347/tests/kraken/driver.html?testName=imaging-darkroom) 07:25:51 INFO - PID 15343 | RSS: Main: 175124480 07:25:51 INFO - PID 15343 | 07:25:55 INFO - PID 15343 | Cycle 1(1): loaded http://localhost:57347/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57347/tests/kraken/driver.html?testName=imaging-desaturate) 07:25:55 INFO - PID 15343 | RSS: Main: 175112192 07:25:55 INFO - PID 15343 | 07:25:58 INFO - PID 15343 | Cycle 1(1): loaded http://localhost:57347/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57347/tests/kraken/driver.html?testName=json-parse-financial) 07:25:59 INFO - PID 15343 | RSS: Main: 175308800 07:25:59 INFO - PID 15343 | 07:26:00 INFO - PID 15343 | Cycle 1(1): loaded http://localhost:57347/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57347/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:26:01 INFO - PID 15343 | RSS: Main: 175386624 07:26:01 INFO - PID 15343 | 07:26:03 INFO - PID 15343 | Cycle 1(1): loaded http://localhost:57347/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57347/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:26:03 INFO - PID 15343 | RSS: Main: 175579136 07:26:03 INFO - PID 15343 | 07:26:05 INFO - PID 15343 | Cycle 1(1): loaded http://localhost:57347/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57347/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:26:06 INFO - PID 15343 | RSS: Main: 172552192 07:26:06 INFO - PID 15343 | 07:26:09 INFO - PID 15343 | Cycle 1(1): loaded http://localhost:57347/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57347/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:26:10 INFO - PID 15343 | RSS: Main: 173121536 07:26:10 INFO - PID 15343 | 07:26:13 INFO - PID 15343 | Cycle 1(1): loaded http://localhost:57347/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57347/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:26:13 INFO - PID 15343 | RSS: Main: 172953600 07:26:13 INFO - PID 15343 | 07:26:15 INFO - PID 15343 | Cycle 1(1): loaded http://localhost:57347/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57347/tests/kraken/driver.html?testName=ai-astar) 07:26:15 INFO - PID 15343 | RSS: Main: 174268416 07:26:15 INFO - PID 15343 | 07:26:15 INFO - PID 15343 | __start_tp_report 07:26:15 INFO - PID 15343 | _x_x_mozilla_page_load 07:26:15 INFO - PID 15343 | _x_x_mozilla_page_load_details 07:26:15 INFO - PID 15343 | |i|pagename|runs| 07:26:15 INFO - PID 15343 | |0;ai-astar;97;109;101;106;108;111;107;98;109;109 07:26:15 INFO - PID 15343 | |1;audio-beat-detection;149;117;157;182;121;144;154;122;171;123 07:26:15 INFO - PID 15343 | |2;audio-dft;165;162;165;163;163;161;165;163;170;163 07:26:15 INFO - PID 15343 | |3;audio-fft;75;76;74;181;75;75;74;75;150;76 07:26:15 INFO - PID 15343 | |4;audio-oscillator;79;78;132;79;78;79;136;78;78;126 07:26:15 INFO - PID 15343 | |5;imaging-gaussian-blur;114;113;115;114;114;115;114;115;114;114 07:26:15 INFO - PID 15343 | |6;imaging-darkroom;152;158;151;150;151;150;150;152;155;151 07:26:15 INFO - PID 15343 | |7;imaging-desaturate;94;94;94;94;94;94;94;95;94;95 07:26:15 INFO - PID 15343 | |8;json-parse-financial;55;56;57;55;55;56;57;59;55;56 07:26:15 INFO - PID 15343 | |9;json-stringify-tinderbox;53;53;53;53;54;54;53;53;54;54 07:26:15 INFO - PID 15343 | |10;stanford-crypto-aes;77;93;76;77;78;76;76;87;87;78 07:26:15 INFO - PID 15343 | |11;stanford-crypto-ccm;127;127;138;127;123;123;134;129;135;170 07:26:15 INFO - PID 15343 | |12;stanford-crypto-pbkdf2;172;176;174;179;175;173;186;179;179;180 07:26:15 INFO - PID 15343 | |13;stanford-crypto-sha256-iterative;72;66;64;64;67;65;64;64;65;65 07:26:15 INFO - PID 15343 | __end_tp_report 07:26:15 INFO - PID 15343 | __start_cc_report 07:26:15 INFO - PID 15343 | _x_x_mozilla_cycle_collect,940 07:26:15 INFO - PID 15343 | __end_cc_report 07:26:15 INFO - PID 15343 | __startTimestamp1502029575699__endTimestamp 07:26:15 INFO - PID 15343 | 07:26:15 INFO - PID 15343 | ------- Summary: start ------- 07:26:15 INFO - PID 15343 | Number of tests: 14 07:26:15 INFO - PID 15343 | 07:26:15 INFO - PID 15343 | [#0] ai-astar Cycles:10 Average:105.50 Median:109.00 stddev:4.99 (4.6%) stddev-sans-first:4.25 07:26:15 INFO - PID 15343 | Values: 97.0 109.0 101.0 106.0 108.0 111.0 107.0 98.0 109.0 109.0 07:26:15 INFO - PID 15343 | 07:26:15 INFO - PID 15343 | [#1] audio-beat-detection Cycles:10 Average:144.00 Median:151.50 stddev:22.73 (15.0%) stddev-sans-first:24.04 07:26:15 INFO - PID 15343 | Values: 149.0 117.0 157.0 182.0 121.0 144.0 154.0 122.0 171.0 123.0 07:26:15 INFO - PID 15343 | 07:26:15 INFO - PID 15343 | [#2] audio-dft Cycles:10 Average:164.00 Median:164.00 stddev:2.49 (1.5%) stddev-sans-first:2.62 07:26:15 INFO - PID 15343 | Values: 165.0 162.0 165.0 163.0 163.0 161.0 165.0 163.0 170.0 163.0 07:26:15 INFO - PID 15343 | 07:26:15 INFO - PID 15343 | [#3] audio-fft Cycles:10 Average:93.10 Median:75.00 stddev:38.86 (51.8%) stddev-sans-first:40.66 07:26:15 INFO - PID 15343 | Values: 75.0 76.0 74.0 181.0 75.0 75.0 74.0 75.0 150.0 76.0 07:26:15 INFO - PID 15343 | 07:26:15 INFO - PID 15343 | [#4] audio-oscillator Cycles:10 Average:94.30 Median:78.00 stddev:25.67 (32.9%) stddev-sans-first:26.62 07:26:15 INFO - PID 15343 | Values: 79.0 78.0 132.0 79.0 78.0 79.0 136.0 78.0 78.0 126.0 07:26:15 INFO - PID 15343 | 07:26:15 INFO - PID 15343 | [#5] imaging-gaussian-blur Cycles:10 Average:114.20 Median:114.00 stddev:0.63 (0.6%) stddev-sans-first:0.67 07:26:15 INFO - PID 15343 | Values: 114.0 113.0 115.0 114.0 114.0 115.0 114.0 115.0 114.0 114.0 07:26:15 INFO - PID 15343 | 07:26:15 INFO - PID 15343 | [#6] imaging-darkroom Cycles:10 Average:152.00 Median:151.50 stddev:2.58 (1.7%) stddev-sans-first:2.74 07:26:15 INFO - PID 15343 | Values: 152.0 158.0 151.0 150.0 151.0 150.0 150.0 152.0 155.0 151.0 07:26:15 INFO - PID 15343 | 07:26:15 INFO - PID 15343 | [#7] imaging-desaturate Cycles:10 Average:94.20 Median:94.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 07:26:15 INFO - PID 15343 | Values: 94.0 94.0 94.0 94.0 94.0 94.0 94.0 95.0 94.0 95.0 07:26:15 INFO - PID 15343 | 07:26:15 INFO - PID 15343 | [#8] json-parse-financial Cycles:10 Average:56.10 Median:56.00 stddev:1.29 (2.3%) stddev-sans-first:1.30 07:26:15 INFO - PID 15343 | Values: 55.0 56.0 57.0 55.0 55.0 56.0 57.0 59.0 55.0 56.0 07:26:15 INFO - PID 15343 | 07:26:15 INFO - PID 15343 | [#9] json-stringify-tinderbox Cycles:10 Average:53.40 Median:53.50 stddev:0.52 (1.0%) stddev-sans-first:0.53 07:26:15 INFO - PID 15343 | Values: 53.0 53.0 53.0 53.0 54.0 54.0 53.0 53.0 54.0 54.0 07:26:15 INFO - PID 15343 | 07:26:15 INFO - PID 15343 | [#10] stanford-crypto-aes Cycles:10 Average:80.50 Median:78.00 stddev:6.13 (7.9%) stddev-sans-first:6.37 07:26:15 INFO - PID 15343 | Values: 77.0 93.0 76.0 77.0 78.0 76.0 76.0 87.0 87.0 78.0 07:26:15 INFO - PID 15343 | 07:26:15 INFO - PID 15343 | [#11] stanford-crypto-ccm Cycles:10 Average:133.30 Median:131.50 stddev:13.83 (10.5%) stddev-sans-first:14.48 07:26:15 INFO - PID 15343 | Values: 127.0 127.0 138.0 127.0 123.0 123.0 134.0 129.0 135.0 170.0 07:26:15 INFO - PID 15343 | 07:26:15 INFO - PID 15343 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:177.30 Median:179.00 stddev:4.16 (2.3%) stddev-sans-first:3.95 07:26:15 INFO - PID 15343 | Values: 172.0 176.0 174.0 179.0 175.0 173.0 186.0 179.0 179.0 180.0 07:26:15 INFO - PID 15343 | 07:26:15 INFO - PID 15343 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.60 Median:65.00 stddev:2.46 (3.8%) stddev-sans-first:1.05 07:26:15 INFO - PID 15343 | Values: 72.0 66.0 64.0 64.0 67.0 65.0 64.0 64.0 65.0 65.0 07:26:15 INFO - PID 15343 | -------- Summary: end -------- 07:26:15 INFO - PID 15343 | 07:26:16 INFO - PID 15343 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 07:26:16 INFO - TEST-INFO | 15343: exit 0 07:26:16 INFO - TEST-OK | kraken | took 61644ms 07:26:16 INFO - SUITE-END | took 1174s 07:26:16 INFO - Completed test suite (00:19:34) 07:26:16 INFO - javascript benchmark 07:26:16 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8641.426842590765, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3158.936821263575, 3175.444297247981, 3186.474231751761, 3201.183698156971, 3203.6155661320645, 6239.126522286872, 6288.182536270278, 6300.495960323175, 6350.110984462179, 6374.394432528914, 6170.598911070777, 6308.558400911938, 6310.0, 6323.0, 6342.14381058557, 5775.2203452534, 5792.507636850873, 5831.620944638596, 5874.676892770896, 5884.440978107073, 5638.689872057035, 5771.105478650816, 5797.71011449428, 5949.613275137102, 5953.464188223059, 5725.685087320196, 5786.508146807484, 5801.535877129841, 5858.326292476378, 5870.324912635059, 5784.797532086357, 5825.0, 5857.648541087548, 5862.677552734598, 5886.823395298148, 5636.887262254773, 5671.6597004179885, 5721.628094173865, 5729.828105156852, 5736.2542869427125, 6208.87582248357, 6217.098520714516, 6297.811065668037, 6307.27466341372, 6312.463440607554, 6733.764318248886, 6780.0, 6786.185657721105, 6817.5568588041615, 6834.1457317835275, 6797.1843378794365, 6805.455563554904, 6842.589444633338, 6913.619750913697, 6923.792286231421, 6187.319394866561, 6281.246250449975, 6287.1198032275515, 6289.0, 6323.430891219767, 6922.203946546211, 6950.3049695030095, 6954.09596752429, 7034.8944765828555, 7048.0, 6694.397504224643, 6737.0, 6741.1236539249585, 6743.460523158135, 6747.561408508432, 6823.078884350549, 6829.6243706596615, 6829.692663830139, 6853.00631408453, 6862.073620061327, 6715.832104197434, 6746.190457145076, 6803.0, 6805.761798337134, 6814.216365117975, 6648.5346025777735, 6744.12326397575, 6787.04981302618, 6839.418649414756, 6857.862842743117, 5417.783288668409, 5423.810166644149, 5437.075697131497, 5446.291982042309, 5506.981208476444, 4695.671303008825, 4724.244120940633, 4747.169245382044, 4748.097861406391, 4749.145153872336, 5781.5952883298605, 5852.473277404969, 5862.560307976919, 5871.64770113786, 5880.529557635379, 6818.454523638097, 6819.215790184192, 6826.044353790473, 6907.965460172667, 6922.342377474132, 5684.54523638108, 5749.8562535936935, 5764.048931926185, 5792.536597072224, 5828.242328497268, 5914.201582786355, 5961.850953726105, 5968.940310596925, 5982.790602328898, 5988.760449581968, 6399.712012959428, 6508.219013718384, 6512.674366281667, 6521.510886683518, 6523.510736694767, 6689.464842812563, 6802.387785099365, 6805.965970170316, 6853.760118395832, 6938.375546200866, 6507.6746162692625, 6514.120593719787, 6532.8366790830605, 6615.140031795836, 6616.90074648871, 6562.376574225632, 6658.5671931324305, 6680.866382672222, 6696.129503164558, 6741.22475915276, 6771.322867713189, 6786.253512113763, 6787.66061696923, 6790.830229244309, 6793.252742198453, 6543.6400997943665, 6547.836304092436, 6575.638339891352, 6580.967095164494, 6685.064091027358, 6624.436922861611, 6654.035164901159, 6686.866262674816, 6729.629870357177, 6736.360045795642, 6546.509011824037, 6559.901601476077, 6593.241777195684, 6647.567908085959, 6648.301928297459, 6610.867782644224, 6668.133142691419, 6776.796696099125, 6777.593344399154, 6777.661116944231, 6426.807195784134, 6451.48388128958, 6471.449926756279, 6544.54188206821, 6557.311482294481], "value": 6189.034147365018, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [758.7382353088186, 784.6273020315348, 806.5241507510569, 819.5492479136477, 839.6599377252213, 40886.79556602216, 41871.37192942108, 41936.79031604838, 41956.0, 41982.58017419825, 37858.621413785855, 38162.61837381625, 38218.23563528728, 38327.42508862369, 38494.615053849455, 6722.731090756376, 6831.248562658104, 6836.555623884432, 6839.316068393171, 6858.3141685831515, 6752.729890804362, 6779.322067793206, 6818.284080171585, 6829.692663830139, 6850.417714494274, 7342.926570734277, 7508.1741008489025, 7538.547687138762, 7580.886286705704, 7606.885896711554, 7518.360939320164, 7556.093268807724, 7582.317591416771, 7583.924160758377, 7585.620718964057, 7310.195878453366, 7407.703691852374, 7493.4005279577505, 7514.135874374462, 7517.398608111338, 39076.41385379222, 39287.8035609823, 39327.606723932964, 39353.21293574141, 39364.40953385702, 3572.231970126409, 3612.9096772580633, 3621.0947263184203, 3624.257027309395, 3633.6911362534215, 31512.36975260482, 31585.684143158505, 31731.841340793148, 31770.364592708018, 31845.363092738247, 4983.053219888209, 4991.4758950310425, 4998.225275082332, 5043.495650434964, 5047.217681259411, 233285.0, 238537.0, 239209.0, 240331.0, 241103.0, 50449.0, 50877.23684144741, 50885.0, 50939.49060509347, 50987.74506127446, 51908.22137667938, 51939.22091168635, 52096.73951630218, 52177.73911130496, 52249.47750522446, 16790.0, 16968.91515542439, 17030.57423564396, 17041.48875533736, 17046.318147274218, 13900.582982510541, 14074.0, 14081.436742530184, 14095.647608809657, 14155.787663185061, 14969.101853888802, 15010.099394036393, 15010.099394036393, 15084.773728394082, 15245.847541524443, 5742.827715168552, 5878.177055212273, 5900.365151280517, 6020.879582408327, 6081.0270356743595, 985.8225519406576, 1008.5360734062414, 1019.5615885169449, 1024.1192574386023, 1025.4001409175567, 23659.526809463714, 24073.7592624075, 24077.759222407552, 24170.0, 24200.394990125387, 1115.2137742891243, 1123.5112725964068, 1132.592266783957, 1136.7385501334575, 1139.350570175009, 12379.133460657848, 12524.060695447877, 16901.408450704166, 16944.661106777796, 17015.744763828552, 234863.0, 235261.0, 235314.0, 236072.0, 237033.0, 49057.75471122622, 49644.25533616998, 58382.70808645929, 59489.0, 60092.0, 1426.2939844776695, 1490.1506141499242, 1493.9103653780808, 1499.4077339451073, 1504.2253239581623, 28064.71935280621, 28674.0, 28676.42647147087, 29224.0, 29758.55362169526, 52970.470295298095, 53545.0, 53651.46348536465, 53701.73149134385, 53720.0, 209297.0, 211180.0, 212011.0, 212127.0, 212668.0, 35882.0, 36487.0, 39253.60746392499, 40510.59489405068, 40531.59468405396, 47879.16966642591, 48815.0, 49493.752531237114, 50008.499915000386, 50232.24651630155, 35586.0, 35697.28605427825, 35852.64147358597, 35904.82047589745, 35956.640433596374, 34650.0, 34907.0, 34923.825380872935, 34948.65051349556, 35248.295034098664, 36693.26613467769, 38224.23551529009, 38503.422448663856, 38533.614663853004, 38595.421068684554, 33797.83101084479, 34344.0, 34466.0, 34493.0, 34729.0, 26162.215133546026, 26386.736132639195, 26410.603840942786, 26604.068857589893, 26761.33096672599], "value": 18034.15022639972, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [570.7003822992929, 581.7672930827669, 583.7606581301667, 585.1661382529895, 591.6479694581723, 22202.222922197725, 23076.0, 23080.538389232206, 23096.88451557744, 23113.653295200584, 25469.0, 26729.0, 27816.3045923852, 27914.581281280745, 27991.160265192077, 6530.771423000196, 6704.2625311215725, 6706.899396509032, 6712.563683360566, 6713.597184168965, 6207.565470417073, 6489.935100648981, 6547.77082802102, 6629.071929929813, 6632.369924857131, 6429.967850160766, 6469.450096741759, 6480.287168411471, 6481.060246264289, 6482.546221764478, 6449.677516124222, 6477.0284457331545, 6489.805305840832, 6493.253275873264, 6493.7727179548965, 5988.221531200959, 6009.218801555813, 6020.5785595008365, 6026.306974697922, 6031.0, 29769.553456698166, 30368.8481557593, 30466.238344041354, 30508.54237186444, 31492.842535787404, 1858.2381223698353, 1916.1281616864433, 1917.0, 1919.9904000479908, 1921.8174273444001, 19545.413637590897, 20146.39560813178, 20172.0, 20277.797222027737, 20345.8982705087, 2416.226807421626, 2459.8401103928186, 2480.8635525046116, 2485.3041148478455, 2516.3834860459124, 142982.0, 146017.0, 146955.0, 147045.0, 147646.0, 14283.214423206824, 15013.774793378108, 15332.693346133237, 15511.457099001707, 15699.607509812346, 23534.529309413716, 24064.75935240625, 24121.0, 24241.0, 24304.270871873872, 10595.894041059644, 10711.143108551298, 10911.399873007062, 10958.452077396098, 11037.282576632653, 10074.093331600192, 10129.797404052026, 10151.289409741396, 10234.795304094025, 10361.689149325532, 9555.808883822423, 9599.904000960041, 9670.468124253233, 9684.903150968541, 9691.951540242253, 2657.6545049143874, 2717.3070866928806, 2791.3858951030743, 2870.985645071761, 2882.798204125691, 952.590386133969, 968.0996673093949, 974.6247694637616, 984.5864736810556, 988.3921388346115, 20282.188712451338, 20428.591428171352, 20439.591208175752, 20666.0, 20680.793192067886, 1031.6389263757774, 1033.426448321174, 1035.2028937717914, 1052.347544522401, 1052.5158427123456, 10923.672289831318, 11426.371549564854, 11439.970402663801, 11481.0, 11504.94247528757, 492046.0, 541059.0, 541838.0, 547157.0, 550161.0, 114652.0, 117452.41273793577, 118271.40864295796, 119335.40332298283, 120473.39763301128, 1208.075658465691, 1213.3629844331797, 1230.3848075962019, 1231.956881509161, 1237.294741997071, 17929.551761206076, 18136.0, 18355.816441835945, 18653.813461865208, 21772.34682959514, 59427.40572594219, 59674.403255966885, 60494.0, 61863.6906815463, 62011.37988620237, 68567.0, 68797.65601171962, 68892.3110768886, 69300.30699693141, 69863.65068174627, 14940.925295373454, 15315.234238288263, 15408.075515469107, 15481.922590387427, 15483.612909676898, 23577.0, 23584.882075589514, 23667.52664946657, 23969.16107936214, 24015.0, 18195.727064094313, 18862.622747545247, 19228.230870765572, 19260.614787704446, 19396.4181074568, 17526.912365438093, 17614.383496577557, 17645.911770441067, 17897.10514474297, 18195.727064093786, 19832.008399579674, 20035.39893803188, 20109.49726256855, 20119.798802011792, 20224.089915953522, 14596.708065838411, 14927.925360373129, 15508.612284692974, 15559.922200388926, 15560.377584896478, 18816.15327310247, 18871.15079821439, 18946.336878209197, 19044.0, 19171.424857254304], "value": 12330.201575783702, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1358.9796153057705, 1410.1186758276078, 1436.7701167813138, 1442.6249175214448, 1446.4286606790317, 13158.868411315883, 13643.249621270827, 13655.522056727992, 13680.38438270279, 14278.0, 14820.481283155092, 15123.92438037811, 15139.621509462242, 15141.0, 15155.545333640008, 2726.4410795786816, 2794.5249307617755, 2795.35706787439, 2795.454886297173, 2795.664520257572, 2716.415970566328, 2787.6097346371525, 2804.761595264405, 2805.3968396794685, 2807.6069350290873, 2704.0806125917184, 2716.9592456113173, 2744.4922689302443, 2744.7529722324985, 2763.77889768818, 2680.2629276948896, 2695.3800625855965, 2723.1830450864663, 2724.8773805178716, 2752.7612574341424, 2629.0404002539126, 2659.534581448239, 2661.308059904419, 2665.4935562243304, 2674.4918465491496, 13671.86328136716, 13981.930090349584, 14005.859941400658, 14009.159450433006, 14019.43922243109, 7794.2205779422175, 8113.066997295327, 8120.309773669245, 8122.796930076736, 8124.796880077986, 5044.495550444926, 5093.236014597803, 5199.818006369759, 5269.2886460327745, 5283.207518872162, 1843.1613615804777, 1847.3349594146232, 1850.7871594766639, 1887.6979683250752, 1890.5651700109051, 22598.322050338353, 23229.0, 23233.419164520852, 23245.18641847544, 23254.65118023231, 7022.683979220948, 7088.7872575303745, 7205.423566114699, 7217.206107328189, 7304.160021597478, 16122.919385402998, 16245.131809841783, 16294.837051629569, 16367.181640917906, 16388.75416868724, 7683.193264707237, 7812.414068944852, 7821.256980586949, 7826.0608726952, 7826.921730782619, 7126.608036558039, 7205.207427183006, 7257.745978890714, 7259.927400726031, 7269.6728647211, 5026.195808670595, 5173.896522069537, 5193.844184674465, 5212.739363031909, 5234.18870075139, 1508.7887695722607, 1512.780646806207, 1518.202943454695, 1531.240803826603, 1544.4131230132703, 863.7149740585592, 867.6139118092389, 890.1098901098901, 893.9016708162097, 906.3247880329197, 7128.322809333105, 7200.567965922061, 7220.205777364486, 7252.492325537161, 7271.927280727231, 722.8482018776011, 735.3749313083943, 743.3272888036336, 986.5708416838555, 1013.0, 5042.319286896295, 5086.033653605803, 5191.6884986900905, 5228.686278823283, 5270.209468579667, 17889.28442862271, 18305.90164590129, 18481.7227741584, 18554.44336669902, 18606.627867442847, 17741.55646108832, 18122.184501697455, 18131.909340453476, 18136.546586335448, 18328.083595820422, 10965.671029869116, 11155.832662510069, 11210.831837522444, 11224.102071834233, 11305.26515776472, 8129.918700813153, 8412.62143203545, 8450.873236901574, 8462.661493540189, 8525.531095789791, 17248.827511725223, 17262.395816146374, 17373.21820518105, 17813.821861781216, 17848.821511784718, 17596.82403175952, 17646.20592073334, 17658.0, 17902.91048544749, 18271.269149234413, 10654.094401975608, 10937.179711521827, 10939.070179034552, 10943.179261555575, 10945.23383363157, 13152.671183220113, 13195.802062969255, 13244.470221191044, 13329.0, 13363.0, 10398.948005259925, 10510.421926794099, 10514.053735163872, 10519.421431821018, 10807.459627018774, 10465.319754215952, 10522.684319470429, 10607.0, 10659.626913058006, 10904.836427453753, 9420.199283060743, 9655.179309758749, 9655.179309758749, 9660.420374777535, 9666.0, 6886.311368863074, 6919.446444284546, 6986.895196572157, 7292.854142917218, 7372.447066470144, 7145.285471452813, 7289.5261807982315, 7297.306755858185, 7318.890216646861, 7386.519876208029], "value": 6431.715855860547, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [500.68682685990706, 500.69568773345435, 522.9241759944808, 534.2173715506784, 535.0476152448642, 6244.7510497900485, 6434.356564343575, 6452.64510451925, 6456.935430645698, 6511.153550038494, 6179.814605561829, 6191.6285022898655, 6213.689315534228, 6256.343083976185, 6276.246850377961, 5012.874678133039, 5025.296458495814, 5034.723090230036, 5056.926660069373, 5083.466236045218, 4952.415227127321, 5003.0, 5042.4201216860165, 5069.974650126745, 5235.921461178085, 5157.381114266274, 5177.767000484987, 5195.142801437758, 5266.947330526684, 5271.762770675309, 5241.842744717665, 5254.474552544753, 5279.222303815053, 5298.36419629643, 5307.681539107666, 4898.510148985109, 4916.729579873106, 4919.139150648658, 4919.237518184651, 4980.526849949249, 6234.659548197159, 6245.56281060326, 6256.562040657156, 6273.592216505913, 6311.715972781236, 6094.567776572502, 6095.3904609538695, 6111.755529778803, 6136.539759518054, 6187.4740647045055, 6694.991502549265, 6703.698333575001, 6738.326167383271, 6747.561408508432, 6752.797416077526, 5141.383034035902, 5349.812756553541, 5360.927814437128, 5378.757955891955, 5392.622516423852, 7016.543924644881, 7025.929740702579, 7084.645767711594, 7134.785956421316, 7244.963775181091, 5570.972145139248, 5576.832695019075, 5577.191307260425, 5614.803481878114, 5659.688717120515, 5601.29983752031, 5601.80393686219, 5603.467670571289, 5605.663660180402, 5672.0, 6034.577579569388, 6083.452489275986, 6103.755849766048, 6118.5716999810475, 6139.938600614026, 6673.833154171088, 6691.197056353269, 6747.954067119605, 6749.460043196533, 6780.355866192704, 1873.4192400355932, 1924.9518762031062, 1928.80711928806, 1981.682930731105, 1986.1161783006423, 1377.6486995816003, 1425.0452197028017, 1427.635952832021, 1439.7696368581187, 1450.4343306110625, 5703.800366987136, 5723.055695810228, 5762.769489220468, 5783.306003279549, 5789.8263052108505, 6751.223609284897, 6751.662416879137, 6791.626460544718, 6914.686209620156, 6944.236134025355, 5778.56660750437, 5794.68212714909, 5811.535077193815, 5852.239208902815, 5858.0248146889935, 3628.4194528875782, 3629.854805807738, 3642.7450078494253, 3659.7804131751645, 3688.446732990073, 6607.900881486781, 6622.801315960529, 6654.467642588581, 6656.933430665631, 6718.428933540606, 6991.370776630128, 7025.873486298548, 7078.504504684725, 7097.148342198866, 7121.786346409616, 6463.450606698483, 6487.345726839626, 6607.075009498674, 6661.367170118734, 6756.966215168893, 6850.554713943578, 6898.448124150156, 6906.723731050903, 6917.336825322388, 6993.930060699531, 6713.295104014203, 6758.966205168943, 6807.693653785493, 6813.557118787263, 6882.174139103139, 6646.404862832982, 6669.366005328726, 6711.959646254838, 6728.461723062045, 6754.86490270182, 5025.899482010413, 5072.442031376472, 5074.543291103819, 5102.72431892027, 5130.923036154386, 6700.49746269022, 6923.653817309014, 7001.0198572198915, 7011.4741394394605, 7027.8945815811785, 6346.650934198663, 6538.803835884931, 6621.172353455818, 6658.966705166443, 6666.600003999775, 6524.063102576632, 6553.475721942328, 6708.6310252936555, 6722.0, 6727.8990815138795, 6498.902516462352, 6534.542582019213, 6572.967135164294, 6603.339666033358, 6617.073609694743, 6592.538522303393, 6703.865922681422, 6709.194896612437, 6739.393454589111, 6762.594244345355, 6442.323556026738, 6495.253045899593, 6501.2523559791225, 6503.934960650522, 6524.510661700487], "value": 5258.478535898086, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [904.7738065483629, 916.5234078279295, 923.9445633262009, 930.5765876526182, 938.8169306985138, 19627.607447851053, 20505.692414613794, 20518.17927282909, 20524.486887827792, 20539.589208215828, 17586.736198956994, 18003.27986880523, 18053.458396248134, 18055.0, 22466.32601021972, 993.9105480506753, 1014.0417305646167, 1015.939043657383, 1023.0332335942537, 1023.1098943918764, 1073.6886302972168, 1074.2694967422149, 1075.0969185883855, 1078.471548941017, 1079.740862193072, 1010.9797804043915, 1102.5920409448515, 1112.3881864974271, 1118.2954738514725, 1118.8545489086448, 1103.2222283290262, 1110.4780753046055, 1110.7945030169403, 1111.1166622535104, 1112.6328311657173, 800.6357107516067, 805.6173317674117, 812.3257696112213, 812.4312980913385, 813.2558708781517, 19129.330473433503, 19310.0, 20103.597928041505, 20196.798032019786, 20422.489437764027, 22457.775422245733, 22561.323160305215, 22954.885225573933, 22994.08023679051, 23028.424289392733, 16584.50246492607, 16893.324267029304, 16904.323827046905, 17190.398336058177, 18083.36708215206, 3629.0745859805843, 3692.2246328271094, 3715.981420092909, 3716.4982727331735, 3716.6655001050035, 131413.0, 134589.0, 135665.0, 138701.0, 138720.30639846838, 17164.828351716573, 17401.91299043497, 17892.194851231725, 17893.552661183316, 17933.641327173646, 31655.84172079171, 32208.516872246935, 32584.185395365304, 32851.3429731404, 32875.17812054718, 8850.424722393023, 8939.821203575892, 8965.148310910454, 9122.361434699507, 9196.540172991323, 4240.554741752133, 4300.935485967713, 4306.89232769177, 4316.676249281317, 4341.544137865479, 5411.0, 5482.0, 5511.889762204733, 5515.0, 5528.44715528444, 1012.5595366015807, 1028.88682244953, 1040.5109598488698, 1042.0985847242232, 1042.760165162017, 492.1706923833352, 510.9259157422153, 511.8643559456747, 513.8330042736126, 513.9357580302462, 10940.288881222854, 10944.23390362683, 11158.553657853758, 11775.293482391084, 11806.822897656542, 567.2852206220192, 569.3907518954679, 575.2550447170923, 581.9592628516048, 590.5541316306161, 4928.408590969107, 5372.8448383597715, 5380.219868119179, 5596.2165296858475, 5793.942060579425, 99575.0, 101097.0, 102372.48813756033, 103176.48411758043, 106048.0, 96232.0, 98123.0, 98562.0, 101644.49177754064, 101786.0, 82347.58826205951, 83074.58462707768, 83797.16202838016, 84285.57857210797, 84848.0, 11786.646400607995, 12298.631041068782, 12419.93790031044, 12436.37818109109, 12663.746725065632, 35682.28635427329, 37616.43575346317, 37770.0, 38521.422178667905, 39267.0, 48202.0, 48449.0, 50533.0, 68534.65732671304, 73699.63150184214, 17020.48938531846, 17184.484465466056, 17232.827671723124, 17349.045802480985, 17349.21928513245, 17990.0, 18289.26842926321, 18327.35854245095, 18682.0, 18980.810191897905, 16767.32930682759, 16831.41090061842, 16869.493915182564, 16914.154292285584, 16962.915185423994, 16390.508284751475, 16600.2529886153, 16698.74951875747, 16732.832671673616, 16832.0, 14664.560063198121, 14749.852501475278, 14956.551303460914, 15181.544553663407, 15624.531264062096, 12658.746825063263, 12986.935065324613, 12988.285644289277, 13006.544770932973, 13100.213987160801, 12968.935155324163, 13200.603981880558, 13477.865221348053, 13733.244671542761, 14210.431582736575], "value": 8945.620387757615, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1527.5, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 109.0, 101.0, 106.0, 108.0, 111.0, 107.0, 98.0, 109.0, 109.0], "value": 105.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 117.0, 157.0, 182.0, 121.0, 144.0, 154.0, 122.0, 171.0, 123.0], "value": 144.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 162.0, 165.0, 163.0, 163.0, 161.0, 165.0, 163.0, 170.0, 163.0], "value": 164.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 74.0, 181.0, 75.0, 75.0, 74.0, 75.0, 150.0, 76.0], "value": 93.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 78.0, 132.0, 79.0, 78.0, 79.0, 136.0, 78.0, 78.0, 126.0], "value": 94.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 113.0, 115.0, 114.0, 114.0, 115.0, 114.0, 115.0, 114.0, 114.0], "value": 114.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 158.0, 151.0, 150.0, 151.0, 150.0, 150.0, 152.0, 155.0, 151.0], "value": 152.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 94.0, 94.0, 94.0, 94.0, 95.0, 94.0, 95.0], "value": 94.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 56.0, 57.0, 55.0, 55.0, 56.0, 57.0, 59.0, 55.0, 56.0], "value": 56.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 53.0, 53.0, 53.0, 54.0, 54.0, 53.0, 53.0, 54.0, 54.0], "value": 53.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 93.0, 76.0, 77.0, 78.0, 76.0, 76.0, 87.0, 87.0, 78.0], "value": 80.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [127.0, 127.0, 138.0, 127.0, 123.0, 123.0, 134.0, 129.0, 135.0, 170.0], "value": 133.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 176.0, 174.0, 179.0, 175.0, 173.0, 186.0, 179.0, 179.0, 180.0], "value": 177.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 66.0, 64.0, 64.0, 67.0, 65.0, 64.0, 64.0, 65.0, 65.0], "value": 65.6, "unit": "score"}]}]} 07:26:16 INFO - Return code: 0 07:26:16 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:26:16 INFO - # TBPL SUCCESS # 07:26:16 INFO - Running post-action listener: _package_coverage_data 07:26:16 INFO - Running post-action listener: _resource_record_post_action 07:26:16 INFO - [mozharness: 2017-08-06 14:26:16.977089Z] Finished run-tests step (success) 07:26:16 INFO - Running post-run listener: _resource_record_post_run 07:26:17 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 4096; Write bytes: 429719552; Read time: 16; Write time: 265808 07:26:17 INFO - TinderboxPrint: CPU usage
13.1% 07:26:17 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 07:26:17 INFO - TinderboxPrint: I/O write bytes / time
429,719,552 / 265,808 07:26:17 INFO - TinderboxPrint: CPU idle
8,261.3 (86.8%) 07:26:17 INFO - TinderboxPrint: CPU user
1,202.6 (12.6%) 07:26:17 INFO - TinderboxPrint: Swap in / out
0 / 0 07:26:17 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 106639360; Read time: 0; Write time: 88048 07:26:17 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 07:26:17 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 0; Write bytes: 322056192; Read time: 0; Write time: 177720 07:26:17 INFO - Running post-run listener: _upload_blobber_files 07:26:17 INFO - Blob upload gear active. 07:26:17 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:26:17 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 07:26:17 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'] 07:26:17 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 07:26:18 INFO - (blobuploader) - INFO - Open directory for files ... 07:26:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 07:26:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:26:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:26:18 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 07:26:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:26:18 INFO - (blobuploader) - INFO - Done attempting. 07:26:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 07:26:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:26:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:26:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 07:26:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:26:19 INFO - (blobuploader) - INFO - Done attempting. 07:26:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:26:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:26:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:26:22 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:26:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:26:22 INFO - (blobuploader) - INFO - Done attempting. 07:26:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 07:26:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:26:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:26:23 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 07:26:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:26:23 INFO - (blobuploader) - INFO - Done attempting. 07:26:23 INFO - (blobuploader) - INFO - Iteration through files over. 07:26:23 INFO - Return code: 0 07:26:23 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:26:23 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:26:23 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5adac3bb1fa1e28722fde9eb9d07457e908cff3ed9543e7c35b0300965aef0498b934decfb545e7b53322c184c2657abaa72fb04a33c8fee806840cbf13d4d4c", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4aabea6297967d398c8d8cf4e1450f59c6e5cae43ee6f3026b4ad7a8e020129096c6adb3404c64ece93856ff2470f0c9a01162ac2b1e50e49aba6b11439a7419", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7193b3ed66ce8a10dbaaf8636e23917d98e253fcc1a237145b8a5e7e63bb7a31b4474c2a982116e8f335c54c73fb9a1f404be04b7434e8b4f984b44f663ed637", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a4990fefeddf4fa49e40f65025dfa0ac512a26678f422247121a95542115f28c334a1adc88feaac47bd53d74cdcc37526716ad0ec5effafddc33ca9773f8c3ff"} 07:26:23 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:26:23 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:26:23 INFO - Contents: 07:26:23 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5adac3bb1fa1e28722fde9eb9d07457e908cff3ed9543e7c35b0300965aef0498b934decfb545e7b53322c184c2657abaa72fb04a33c8fee806840cbf13d4d4c", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4aabea6297967d398c8d8cf4e1450f59c6e5cae43ee6f3026b4ad7a8e020129096c6adb3404c64ece93856ff2470f0c9a01162ac2b1e50e49aba6b11439a7419", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7193b3ed66ce8a10dbaaf8636e23917d98e253fcc1a237145b8a5e7e63bb7a31b4474c2a982116e8f335c54c73fb9a1f404be04b7434e8b4f984b44f663ed637", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a4990fefeddf4fa49e40f65025dfa0ac512a26678f422247121a95542115f28c334a1adc88feaac47bd53d74cdcc37526716ad0ec5effafddc33ca9773f8c3ff"} 07:26:23 INFO - Running post-run listener: copy_logs_to_upload_dir 07:26:23 INFO - Copying logs to upload dir... 07:26:23 INFO - mkdir: /builds/slave/test/build/upload/logs 07:26:23 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1250.993764 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 51 secs) (at 2017-08-06 07:26:23.507163) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-06 07:26:23.511490) ========= 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=a0d2d2de893abaa8702a9954000001a7-1502016693.72581-2051344785 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/5adac3bb1fa1e28722fde9eb9d07457e908cff3ed9543e7c35b0300965aef0498b934decfb545e7b53322c184c2657abaa72fb04a33c8fee806840cbf13d4d4c", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4aabea6297967d398c8d8cf4e1450f59c6e5cae43ee6f3026b4ad7a8e020129096c6adb3404c64ece93856ff2470f0c9a01162ac2b1e50e49aba6b11439a7419", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7193b3ed66ce8a10dbaaf8636e23917d98e253fcc1a237145b8a5e7e63bb7a31b4474c2a982116e8f335c54c73fb9a1f404be04b7434e8b4f984b44f663ed637", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a4990fefeddf4fa49e40f65025dfa0ac512a26678f422247121a95542115f28c334a1adc88feaac47bd53d74cdcc37526716ad0ec5effafddc33ca9773f8c3ff"} build_url:https://queue.taskcluster.net/v1/task/Ph1H-2ZlRnGCNKdcz7C8dw/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011253 build_url: 'https://queue.taskcluster.net/v1/task/Ph1H-2ZlRnGCNKdcz7C8dw/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5adac3bb1fa1e28722fde9eb9d07457e908cff3ed9543e7c35b0300965aef0498b934decfb545e7b53322c184c2657abaa72fb04a33c8fee806840cbf13d4d4c", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4aabea6297967d398c8d8cf4e1450f59c6e5cae43ee6f3026b4ad7a8e020129096c6adb3404c64ece93856ff2470f0c9a01162ac2b1e50e49aba6b11439a7419", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7193b3ed66ce8a10dbaaf8636e23917d98e253fcc1a237145b8a5e7e63bb7a31b4474c2a982116e8f335c54c73fb9a1f404be04b7434e8b4f984b44f663ed637", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a4990fefeddf4fa49e40f65025dfa0ac512a26678f422247121a95542115f28c334a1adc88feaac47bd53d74cdcc37526716ad0ec5effafddc33ca9773f8c3ff"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-06 07:26:23.538756) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-06 07:26:23.539053) ========= 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=a0d2d2de893abaa8702a9954000001a7-1502016693.72581-2051344785 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004462 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-06 07:26:23.618651) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-06 07:26:23.618939) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-06 07:26:23.622229) ========= ========= Total master_lag: 0.19 =========